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

• d14a6f6a6be8e9019366d63c3781e3356fe9b3f0 (6 years ago)

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

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

[03:25:56.764] New invocation is queued and will start shortly
[03:25:58.221] Starting the invocation (attempt 1)
[03:25:58.272] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:25:58.272] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:25:58.272] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9088913181729147808",
  "parameters_json": "{\"builder_name\":\"linux-pnacl-x86_64-tests-arm\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"d14a6f6a6be8e9019366d63c3781e3356fe9b3f0\"}}",
  "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:9088913181729147808",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
    "user_agent:luci-scheduler",
    "buildset:commit/git/d14a6f6a6be8e9019366d63c3781e3356fe9b3f0",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/d14a6f6a6be8e9019366d63c3781e3356fe9b3f0",
    "gitiles_ref:refs/heads/master"
  ]
}
[03:25:59.583] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1548300358354743",
    "id": "8923483119397082480",
    "lease_expiration_ts": "1548451559302200",
    "lease_key": "897951013",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-arm\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"d14a6f6a6be8e9019366d63c3781e3356fe9b3f0\"}}",
    "project": "nacl",
    "result_details_json": "null",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1548300359475377",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4697",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/d14a6f6a6be8e9019366d63c3781e3356fe9b3f0",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/d14a6f6a6be8e9019366d63c3781e3356fe9b3f0",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9088913181729147808",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
      "swarming_dimension:caches:builder_260015d2e489656b9034d382dc1874ce0c1f399ed411416e1867fa173e3e19d1_v2",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.nacl.toolchain",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4697",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8923483119397082480",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-arm",
      "swarming_tag:buildset:commit/git/d14a6f6a6be8e9019366d63c3781e3356fe9b3f0",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/d14a6f6a6be8e9019366d63c3781e3356fe9b3f0",
      "swarming_tag:caches:builder_260015d2e489656b9034d382dc1874ce0c1f399ed411416e1867fa173e3e19d1_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:gitiles_ref:refs/heads/master",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8923483119397082480/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.nacl.toolchain",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9088913181729147808",
      "swarming_tag:scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
      "swarming_tag:service_account:nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:a883ea2343e81ad9b4be8c2424a65260c5b29a9f",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4296b61cd63d9110",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1548300359475391",
    "url": "https://ci.chromium.org/b/8923483119397082480",
    "utcnow_ts": "1548300359566622"
  }
}
[03:25:59.583] Task URL: https://ci.chromium.org/b/8923483119397082480
[03:25:59.583] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:2:0) after 1m0s
[03:26:04.308] Received PubSub notification, asking Buildbucket for the build status
[03:26:04.345] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:59.604] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:2:0)
[03:26:59.604] Timer tick, asking Buildbucket for the build status
[03:26:59.657] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:59.657] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:4:0) after 1m0s
[03:27:59.671] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:4:0)
[03:27:59.671] Timer tick, asking Buildbucket for the build status
[03:27:59.774] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:59.774] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:5:0) after 1m0s
[03:28:59.790] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:5:0)
[03:28:59.790] Timer tick, asking Buildbucket for the build status
[03:28:59.863] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:59.863] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:6:0) after 1m0s
[03:29:59.880] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:6:0)
[03:29:59.880] Timer tick, asking Buildbucket for the build status
[03:29:59.929] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:59.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:7:0) after 1m0s
[03:30:59.948] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:7:0)
[03:30:59.948] Timer tick, asking Buildbucket for the build status
[03:31:00.016] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:00.016] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:8:0) after 1m0s
[03:32:00.054] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:8:0)
[03:32:00.054] Timer tick, asking Buildbucket for the build status
[03:32:00.110] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:00.110] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:9:0) after 1m0s
[03:33:00.127] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:9:0)
[03:33:00.127] Timer tick, asking Buildbucket for the build status
[03:33:00.201] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:00.201] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:10:0) after 1m0s
[03:34:00.230] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:10:0)
[03:34:00.230] Timer tick, asking Buildbucket for the build status
[03:34:00.336] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:00.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:11:0) after 1m0s
[03:35:00.432] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:11:0)
[03:35:00.432] Timer tick, asking Buildbucket for the build status
[03:35:00.497] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:00.497] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:12:0) after 1m0s
[03:36:00.542] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:12:0)
[03:36:00.542] Timer tick, asking Buildbucket for the build status
[03:36:00.595] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:00.595] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:13:0) after 1m0s
[03:37:00.618] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:13:0)
[03:37:00.618] Timer tick, asking Buildbucket for the build status
[03:37:00.655] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:00.655] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:14:0) after 1m0s
[03:38:00.671] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:14:0)
[03:38:00.671] Timer tick, asking Buildbucket for the build status
[03:38:00.729] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:00.729] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:15:0) after 1m0s
[03:39:00.750] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:15:0)
[03:39:00.750] Timer tick, asking Buildbucket for the build status
[03:39:00.827] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:00.827] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:16:0) after 1m0s
[03:40:00.853] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:16:0)
[03:40:00.853] Timer tick, asking Buildbucket for the build status
[03:40:00.905] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:00.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:17:0) after 1m0s
[03:41:00.940] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:17:0)
[03:41:00.940] Timer tick, asking Buildbucket for the build status
[03:41:00.988] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:00.988] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:18:0) after 1m0s
[03:42:01.007] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:18:0)
[03:42:01.007] Timer tick, asking Buildbucket for the build status
[03:42:01.166] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:01.166] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:19:0) after 1m0s
[03:43:01.185] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:19:0)
[03:43:01.185] Timer tick, asking Buildbucket for the build status
[03:43:01.302] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:01.302] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:20:0) after 1m0s
[03:44:01.381] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:20:0)
[03:44:01.381] Timer tick, asking Buildbucket for the build status
[03:44:01.521] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:01.521] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:21:0) after 1m0s
[03:45:01.539] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:21:0)
[03:45:01.539] Timer tick, asking Buildbucket for the build status
[03:45:01.614] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:01.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:22:0) after 1m0s
[03:46:01.639] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:22:0)
[03:46:01.639] Timer tick, asking Buildbucket for the build status
[03:46:01.797] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:01.797] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:23:0) after 1m0s
[03:47:01.816] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:23:0)
[03:47:01.816] Timer tick, asking Buildbucket for the build status
[03:47:01.893] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:01.893] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:24:0) after 1m0s
[03:48:01.912] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:24:0)
[03:48:01.913] Timer tick, asking Buildbucket for the build status
[03:48:02.087] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:02.087] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:25:0) after 1m0s
[03:49:02.107] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:25:0)
[03:49:02.107] Timer tick, asking Buildbucket for the build status
[03:49:02.162] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:02.162] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:26:0) after 1m0s
[03:50:02.205] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:26:0)
[03:50:02.205] Timer tick, asking Buildbucket for the build status
[03:50:02.337] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:02.337] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:27:0) after 1m0s
[03:51:02.443] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:27:0)
[03:51:02.443] Timer tick, asking Buildbucket for the build status
[03:51:02.755] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:02.755] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:28:0) after 1m0s
[03:52:02.775] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:28:0)
[03:52:02.775] Timer tick, asking Buildbucket for the build status
[03:52:02.845] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:02.845] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:29:0) after 1m0s
[03:53:02.867] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:29:0)
[03:53:02.867] Timer tick, asking Buildbucket for the build status
[03:53:02.925] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:02.925] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:30:0) after 1m0s
[03:54:02.953] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:30:0)
[03:54:02.953] Timer tick, asking Buildbucket for the build status
[03:54:03.181] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:03.181] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:31:0) after 1m0s
[03:55:03.219] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:31:0)
[03:55:03.219] Timer tick, asking Buildbucket for the build status
[03:55:03.287] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:03.287] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:32:0) after 1m0s
[03:56:03.385] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:32:0)
[03:56:03.385] Timer tick, asking Buildbucket for the build status
[03:56:03.447] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:03.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:33:0) after 1m0s
[03:57:03.467] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:33:0)
[03:57:03.467] Timer tick, asking Buildbucket for the build status
[03:57:03.640] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:03.640] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:34:0) after 1m0s
[03:58:03.665] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:34:0)
[03:58:03.665] Timer tick, asking Buildbucket for the build status
[03:58:03.701] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:03.701] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:35:0) after 1m0s
[03:59:03.719] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:35:0)
[03:59:03.719] Timer tick, asking Buildbucket for the build status
[03:59:03.802] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:03.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:36:0) after 1m0s
[04:00:03.850] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:36:0)
[04:00:03.850] Timer tick, asking Buildbucket for the build status
[04:00:03.916] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:03.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:37:0) after 1m0s
[04:01:03.943] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:37:0)
[04:01:03.943] Timer tick, asking Buildbucket for the build status
[04:01:03.984] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:03.984] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:38:0) after 1m0s
[04:02:04.037] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:38:0)
[04:02:04.037] Timer tick, asking Buildbucket for the build status
[04:02:04.170] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:04.170] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:39:0) after 1m0s
[04:03:04.228] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:39:0)
[04:03:04.228] Timer tick, asking Buildbucket for the build status
[04:03:04.307] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:04.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:40:0) after 1m0s
[04:04:04.332] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:40:0)
[04:04:04.332] Timer tick, asking Buildbucket for the build status
[04:04:04.425] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:04.425] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:41:0) after 1m0s
[04:05:04.442] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:41:0)
[04:05:04.442] Timer tick, asking Buildbucket for the build status
[04:05:04.483] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:04.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:42:0) after 1m0s
[04:06:04.529] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:42:0)
[04:06:04.529] Timer tick, asking Buildbucket for the build status
[04:06:04.592] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:04.592] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:43:0) after 1m0s
[04:07:04.622] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:43:0)
[04:07:04.622] Timer tick, asking Buildbucket for the build status
[04:07:04.667] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:04.667] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:44:0) after 1m0s
[04:08:04.732] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:44:0)
[04:08:04.732] Timer tick, asking Buildbucket for the build status
[04:08:04.818] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:04.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:45:0) after 1m0s
[04:09:04.841] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:45:0)
[04:09:04.841] Timer tick, asking Buildbucket for the build status
[04:09:04.914] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:04.914] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:46:0) after 1m0s
[04:10:05.024] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:46:0)
[04:10:05.024] Timer tick, asking Buildbucket for the build status
[04:10:05.065] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:05.065] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:47:0) after 1m0s
[04:11:05.090] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:47:0)
[04:11:05.090] Timer tick, asking Buildbucket for the build status
[04:11:05.166] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:05.166] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:48:0) after 1m0s
[04:12:05.190] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:48:0)
[04:12:05.190] Timer tick, asking Buildbucket for the build status
[04:12:05.289] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:05.289] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:49:0) after 1m0s
[04:13:05.309] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:49:0)
[04:13:05.309] Timer tick, asking Buildbucket for the build status
[04:13:05.366] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:05.366] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:50:0) after 1m0s
[04:14:05.438] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:50:0)
[04:14:05.438] Timer tick, asking Buildbucket for the build status
[04:14:05.506] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:05.506] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:51:0) after 1m0s
[04:15:05.552] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:51:0)
[04:15:05.552] Timer tick, asking Buildbucket for the build status
[04:15:05.602] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:05.602] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:52:0) after 1m0s
[04:16:05.618] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:52:0)
[04:16:05.618] Timer tick, asking Buildbucket for the build status
[04:16:05.767] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:05.767] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:53:0) after 1m0s
[04:17:05.784] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:53:0)
[04:17:05.785] Timer tick, asking Buildbucket for the build status
[04:17:05.909] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:05.909] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:54:0) after 1m0s
[04:18:06.068] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:54:0)
[04:18:06.068] Timer tick, asking Buildbucket for the build status
[04:18:06.254] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:06.254] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:55:0) after 1m0s
[04:19:06.279] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:55:0)
[04:19:06.279] Timer tick, asking Buildbucket for the build status
[04:19:06.327] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:06.327] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:56:0) after 1m0s
[04:20:06.375] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:56:0)
[04:20:06.376] Timer tick, asking Buildbucket for the build status
[04:20:06.410] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:06.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:57:0) after 1m0s
[04:21:06.440] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:57:0)
[04:21:06.440] Timer tick, asking Buildbucket for the build status
[04:21:06.588] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:06.588] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:58:0) after 1m0s
[04:22:06.647] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:58:0)
[04:22:06.647] Timer tick, asking Buildbucket for the build status
[04:22:06.763] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:06.763] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:59:0) after 1m0s
[04:23:06.784] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:59:0)
[04:23:06.784] Timer tick, asking Buildbucket for the build status
[04:23:06.845] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:06.845] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:60:0) after 1m0s
[04:24:06.877] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:60:0)
[04:24:06.877] Timer tick, asking Buildbucket for the build status
[04:24:06.919] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:06.919] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:61:0) after 1m0s
[04:25:06.942] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:61:0)
[04:25:06.942] Timer tick, asking Buildbucket for the build status
[04:25:06.992] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:06.992] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:62:0) after 1m0s
[04:26:07.057] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:62:0)
[04:26:07.057] Timer tick, asking Buildbucket for the build status
[04:26:07.141] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:07.141] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:63:0) after 1m0s
[04:27:07.162] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:63:0)
[04:27:07.162] Timer tick, asking Buildbucket for the build status
[04:27:07.271] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:07.271] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:64:0) after 1m0s
[04:28:07.291] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:64:0)
[04:28:07.291] Timer tick, asking Buildbucket for the build status
[04:28:07.374] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:07.374] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:65:0) after 1m0s
[04:29:07.403] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:65:0)
[04:29:07.403] Timer tick, asking Buildbucket for the build status
[04:29:07.466] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:07.466] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:66:0) after 1m0s
[04:30:07.499] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:66:0)
[04:30:07.499] Timer tick, asking Buildbucket for the build status
[04:30:07.532] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:07.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:67:0) after 1m0s
[04:31:07.559] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:67:0)
[04:31:07.559] Timer tick, asking Buildbucket for the build status
[04:31:07.645] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:07.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:68:0) after 1m0s
[04:32:07.676] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:68:0)
[04:32:07.676] Timer tick, asking Buildbucket for the build status
[04:32:07.722] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:07.722] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:69:0) after 1m0s
[04:33:07.762] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:69:0)
[04:33:07.762] Timer tick, asking Buildbucket for the build status
[04:33:07.822] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:07.822] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:70:0) after 1m0s
[04:34:07.846] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:70:0)
[04:34:07.846] Timer tick, asking Buildbucket for the build status
[04:34:07.884] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:07.884] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:71:0) after 1m0s
[04:35:07.903] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:71:0)
[04:35:07.903] Timer tick, asking Buildbucket for the build status
[04:35:07.972] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:07.972] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:72:0) after 1m0s
[04:36:08.035] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:72:0)
[04:36:08.035] Timer tick, asking Buildbucket for the build status
[04:36:08.075] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:08.075] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:73:0) after 1m0s
[04:37:08.096] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:73:0)
[04:37:08.096] Timer tick, asking Buildbucket for the build status
[04:37:08.176] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:08.176] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:74:0) after 1m0s
[04:38:08.213] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:74:0)
[04:38:08.213] Timer tick, asking Buildbucket for the build status
[04:38:08.266] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:08.266] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:75:0) after 1m0s
[04:39:08.292] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:75:0)
[04:39:08.292] Timer tick, asking Buildbucket for the build status
[04:39:08.476] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:08.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:76:0) after 1m0s
[04:40:08.514] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:76:0)
[04:40:08.514] Timer tick, asking Buildbucket for the build status
[04:40:08.571] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:08.571] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:77:0) after 1m0s
[04:41:08.697] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:77:0)
[04:41:08.697] Timer tick, asking Buildbucket for the build status
[04:41:08.769] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:08.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:78:0) after 1m0s
[04:42:08.813] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:78:0)
[04:42:08.813] Timer tick, asking Buildbucket for the build status
[04:42:08.844] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:08.844] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:79:0) after 1m0s
[04:43:08.866] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:79:0)
[04:43:08.866] Timer tick, asking Buildbucket for the build status
[04:43:08.917] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:08.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:80:0) after 1m0s
[04:44:08.937] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:80:0)
[04:44:08.937] Timer tick, asking Buildbucket for the build status
[04:44:08.993] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:08.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:81:0) after 1m0s
[04:45:09.013] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:81:0)
[04:45:09.013] Timer tick, asking Buildbucket for the build status
[04:45:09.125] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:09.125] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:82:0) after 1m0s
[04:46:09.146] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:82:0)
[04:46:09.146] Timer tick, asking Buildbucket for the build status
[04:46:09.228] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:09.228] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:83:0) after 1m0s
[04:47:09.247] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:83:0)
[04:47:09.247] Timer tick, asking Buildbucket for the build status
[04:47:09.311] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:09.311] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:84:0) after 1m0s
[04:48:09.341] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:84:0)
[04:48:09.341] Timer tick, asking Buildbucket for the build status
[04:48:09.380] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:09.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:85:0) after 1m0s
[04:49:09.402] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:85:0)
[04:49:09.402] Timer tick, asking Buildbucket for the build status
[04:49:09.464] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:09.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:86:0) after 1m0s
[04:50:09.485] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:86:0)
[04:50:09.485] Timer tick, asking Buildbucket for the build status
[04:50:09.522] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:09.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:87:0) after 1m0s
[04:51:09.551] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:87:0)
[04:51:09.551] Timer tick, asking Buildbucket for the build status
[04:51:09.609] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:09.609] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:88:0) after 1m0s
[04:52:09.632] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:88:0)
[04:52:09.632] Timer tick, asking Buildbucket for the build status
[04:52:09.675] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:09.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:89:0) after 1m0s
[04:53:09.698] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:89:0)
[04:53:09.698] Timer tick, asking Buildbucket for the build status
[04:53:09.756] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:09.756] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:90:0) after 1m0s
[04:54:09.777] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:90:0)
[04:54:09.777] Timer tick, asking Buildbucket for the build status
[04:54:09.818] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:09.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:91:0) after 1m0s
[04:55:09.844] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:91:0)
[04:55:09.844] Timer tick, asking Buildbucket for the build status
[04:55:09.968] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:09.968] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:92:0) after 1m0s
[04:56:10.026] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:92:0)
[04:56:10.026] Timer tick, asking Buildbucket for the build status
[04:56:10.113] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:10.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:93:0) after 1m0s
[04:57:10.139] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:93:0)
[04:57:10.139] Timer tick, asking Buildbucket for the build status
[04:57:10.179] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:10.179] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:94:0) after 1m0s
[04:58:10.204] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:94:0)
[04:58:10.204] Timer tick, asking Buildbucket for the build status
[04:58:10.370] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:10.370] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:95:0) after 1m0s
[04:59:10.419] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:95:0)
[04:59:10.419] Timer tick, asking Buildbucket for the build status
[04:59:10.463] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:10.463] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:96:0) after 1m0s
[05:00:10.488] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:96:0)
[05:00:10.488] Timer tick, asking Buildbucket for the build status
[05:00:10.555] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:10.555] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:97:0) after 1m0s
[05:01:10.658] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:97:0)
[05:01:10.658] Timer tick, asking Buildbucket for the build status
[05:01:10.700] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:10.700] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:98:0) after 1m0s
[05:02:10.882] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:98:0)
[05:02:10.882] Timer tick, asking Buildbucket for the build status
[05:02:10.981] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:10.981] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:99:0) after 1m0s
[05:03:11.012] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:99:0)
[05:03:11.012] Timer tick, asking Buildbucket for the build status
[05:03:11.052] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:11.052] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:100:0) after 1m0s
[05:04:11.094] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:100:0)
[05:04:11.094] Timer tick, asking Buildbucket for the build status
[05:04:11.193] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:11.193] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:101:0) after 1m0s
[05:05:11.217] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:101:0)
[05:05:11.217] Timer tick, asking Buildbucket for the build status
[05:05:11.306] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:11.306] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:102:0) after 1m0s
[05:06:11.347] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:102:0)
[05:06:11.347] Timer tick, asking Buildbucket for the build status
[05:06:11.454] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:11.454] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:103:0) after 1m0s
[05:07:11.479] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:103:0)
[05:07:11.479] Timer tick, asking Buildbucket for the build status
[05:07:11.546] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:11.546] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:104:0) after 1m0s
[05:08:11.565] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:104:0)
[05:08:11.565] Timer tick, asking Buildbucket for the build status
[05:08:11.663] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:11.663] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:105:0) after 1m0s
[05:09:11.691] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:105:0)
[05:09:11.691] Timer tick, asking Buildbucket for the build status
[05:09:11.858] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:11.858] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:106:0) after 1m0s
[05:10:11.944] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:106:0)
[05:10:11.944] Timer tick, asking Buildbucket for the build status
[05:10:11.982] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:11.982] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:107:0) after 1m0s
[05:11:12.045] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:107:0)
[05:11:12.045] Timer tick, asking Buildbucket for the build status
[05:11:12.105] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:12.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:108:0) after 1m0s
[05:12:12.134] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:108:0)
[05:12:12.134] Timer tick, asking Buildbucket for the build status
[05:12:12.193] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:12.193] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:109:0) after 1m0s
[05:13:12.218] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:109:0)
[05:13:12.218] Timer tick, asking Buildbucket for the build status
[05:13:12.352] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:12.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:110:0) after 1m0s
[05:14:12.383] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:110:0)
[05:14:12.383] Timer tick, asking Buildbucket for the build status
[05:14:12.459] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:12.459] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:111:0) after 1m0s
[05:15:12.483] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:111:0)
[05:15:12.483] Timer tick, asking Buildbucket for the build status
[05:15:12.524] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:12.524] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:112:0) after 1m0s
[05:16:12.551] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:112:0)
[05:16:12.551] Timer tick, asking Buildbucket for the build status
[05:16:12.673] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:12.673] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:113:0) after 1m0s
[05:17:12.701] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:113:0)
[05:17:12.701] Timer tick, asking Buildbucket for the build status
[05:17:12.752] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:12.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:114:0) after 1m0s
[05:18:12.789] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:114:0)
[05:18:12.789] Timer tick, asking Buildbucket for the build status
[05:18:12.853] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:12.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:115:0) after 1m0s
[05:19:12.878] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:115:0)
[05:19:12.878] Timer tick, asking Buildbucket for the build status
[05:19:12.967] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:12.967] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:116:0) after 1m0s
[05:20:12.991] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:116:0)
[05:20:12.991] Timer tick, asking Buildbucket for the build status
[05:20:13.103] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:13.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:117:0) after 1m0s
[05:21:13.129] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:117:0)
[05:21:13.129] Timer tick, asking Buildbucket for the build status
[05:21:13.301] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:13.301] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:118:0) after 1m0s
[05:22:13.325] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:118:0)
[05:22:13.325] Timer tick, asking Buildbucket for the build status
[05:22:13.401] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:13.401] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:119:0) after 1m0s
[05:23:13.424] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:119:0)
[05:23:13.424] Timer tick, asking Buildbucket for the build status
[05:23:13.469] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:13.469] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:120:0) after 1m0s
[05:24:13.492] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:120:0)
[05:24:13.492] Timer tick, asking Buildbucket for the build status
[05:24:13.577] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:13.577] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:121:0) after 1m0s
[05:25:13.603] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:121:0)
[05:25:13.603] Timer tick, asking Buildbucket for the build status
[05:25:13.670] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:13.670] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:122:0) after 1m0s
[05:26:13.724] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:122:0)
[05:26:13.724] Timer tick, asking Buildbucket for the build status
[05:26:13.786] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:13.786] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:123:0) after 1m0s
[05:27:13.810] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:123:0)
[05:27:13.810] Timer tick, asking Buildbucket for the build status
[05:27:13.858] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:13.858] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:124:0) after 1m0s
[05:28:13.914] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:124:0)
[05:28:13.914] Timer tick, asking Buildbucket for the build status
[05:28:13.984] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:13.984] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:125:0) after 1m0s
[05:29:14.035] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:125:0)
[05:29:14.035] Timer tick, asking Buildbucket for the build status
[05:29:14.067] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:14.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:126:0) after 1m0s
[05:30:14.093] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:126:0)
[05:30:14.093] Timer tick, asking Buildbucket for the build status
[05:30:14.196] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:14.197] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:127:0) after 1m0s
[05:31:14.221] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:127:0)
[05:31:14.221] Timer tick, asking Buildbucket for the build status
[05:31:14.257] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:14.257] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:128:0) after 1m0s
[05:32:14.363] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:128:0)
[05:32:14.363] Timer tick, asking Buildbucket for the build status
[05:32:14.417] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:14.417] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:129:0) after 1m0s
[05:33:14.447] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:129:0)
[05:33:14.447] Timer tick, asking Buildbucket for the build status
[05:33:14.479] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:14.479] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:130:0) after 1m0s
[05:34:14.512] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:130:0)
[05:34:14.512] Timer tick, asking Buildbucket for the build status
[05:34:14.688] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:14.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:131:0) after 1m0s
[05:35:14.711] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:131:0)
[05:35:14.711] Timer tick, asking Buildbucket for the build status
[05:35:14.795] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:14.795] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:132:0) after 1m0s
[05:36:14.848] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:132:0)
[05:36:14.848] Timer tick, asking Buildbucket for the build status
[05:36:15.304] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:15.304] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:133:0) after 1m0s
[05:37:15.330] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:133:0)
[05:37:15.330] Timer tick, asking Buildbucket for the build status
[05:37:15.373] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:15.373] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:134:0) after 1m0s
[05:38:15.401] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:134:0)
[05:38:15.401] Timer tick, asking Buildbucket for the build status
[05:38:15.455] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:15.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:135:0) after 1m0s
[05:39:15.533] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:135:0)
[05:39:15.533] Timer tick, asking Buildbucket for the build status
[05:39:15.574] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:15.574] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:136:0) after 1m0s
[05:40:15.596] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:136:0)
[05:40:15.596] Timer tick, asking Buildbucket for the build status
[05:40:15.652] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:15.652] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:137:0) after 1m0s
[05:41:15.682] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:137:0)
[05:41:15.682] Timer tick, asking Buildbucket for the build status
[05:41:15.750] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:15.750] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:138:0) after 1m0s
[05:42:15.779] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:138:0)
[05:42:15.779] Timer tick, asking Buildbucket for the build status
[05:42:15.841] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:15.841] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:139:0) after 1m0s
[05:43:15.863] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:139:0)
[05:43:15.863] Timer tick, asking Buildbucket for the build status
[05:43:15.900] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:15.900] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:140:0) after 1m0s
[05:44:15.936] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:140:0)
[05:44:15.936] Timer tick, asking Buildbucket for the build status
[05:44:15.990] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:15.990] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:141:0) after 1m0s
[05:45:16.013] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:141:0)
[05:45:16.013] Timer tick, asking Buildbucket for the build status
[05:45:16.044] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:16.044] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:142:0) after 1m0s
[05:46:16.071] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:142:0)
[05:46:16.071] Timer tick, asking Buildbucket for the build status
[05:46:16.175] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:16.175] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:143:0) after 1m0s
[05:47:16.216] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:143:0)
[05:47:16.216] Timer tick, asking Buildbucket for the build status
[05:47:16.265] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:16.265] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:144:0) after 1m0s
[05:48:16.286] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:144:0)
[05:48:16.286] Timer tick, asking Buildbucket for the build status
[05:48:16.397] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:16.398] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:145:0) after 1m0s
[05:49:16.420] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:145:0)
[05:49:16.420] Timer tick, asking Buildbucket for the build status
[05:49:16.509] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:16.509] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:146:0) after 1m0s
[05:50:16.531] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:146:0)
[05:50:16.531] Timer tick, asking Buildbucket for the build status
[05:50:16.607] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:16.607] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:147:0) after 1m0s
[05:51:16.633] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:147:0)
[05:51:16.633] Timer tick, asking Buildbucket for the build status
[05:51:16.673] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:16.673] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:148:0) after 1m0s
[05:52:16.696] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:148:0)
[05:52:16.696] Timer tick, asking Buildbucket for the build status
[05:52:16.775] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:16.775] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:149:0) after 1m0s
[05:53:16.829] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:149:0)
[05:53:16.829] Timer tick, asking Buildbucket for the build status
[05:53:16.887] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:16.887] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:150:0) after 1m0s
[05:54:16.907] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:150:0)
[05:54:16.907] Timer tick, asking Buildbucket for the build status
[05:54:16.960] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:16.960] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:151:0) after 1m0s
[05:55:16.985] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:151:0)
[05:55:16.985] Timer tick, asking Buildbucket for the build status
[05:55:17.032] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:17.032] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:152:0) after 1m0s
[05:56:17.065] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:152:0)
[05:56:17.065] Timer tick, asking Buildbucket for the build status
[05:56:17.124] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:17.124] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:153:0) after 1m0s
[05:57:17.149] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:153:0)
[05:57:17.149] Timer tick, asking Buildbucket for the build status
[05:57:17.222] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:17.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:154:0) after 1m0s
[05:58:17.244] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:154:0)
[05:58:17.244] Timer tick, asking Buildbucket for the build status
[05:58:17.394] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:17.394] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:155:0) after 1m0s
[05:59:17.414] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:155:0)
[05:59:17.414] Timer tick, asking Buildbucket for the build status
[05:59:17.450] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:17.450] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:156:0) after 1m0s
[06:00:17.473] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:156:0)
[06:00:17.473] Timer tick, asking Buildbucket for the build status
[06:00:17.597] Build 8923483119397082480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:17.597] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9088913181729147808:157:0) after 1m0s
[06:00:54.349] Received PubSub notification, asking Buildbucket for the build status
[06:00:54.401] Build 8923483119397082480: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[06:00:54.401] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "completed_ts": "1548309653465015",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1548300358354743",
    "failure_reason": "BUILD_FAILURE",
    "id": "8923483119397082480",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-arm\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"d14a6f6a6be8e9019366d63c3781e3356fe9b3f0\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"Failure annotated steps\\nFailure torture_tests_clang arm\\nFailure llvm-test-suite arm --opt O3f --opt O2b\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"4026-11b7a84\"], \"machine_type\": [\"n1-standard-16\"], \"gpu\": [\"none\"], \"cores\": [\"16\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-16-145e5bab-us-west1-c-vplb\"], \"pool\": [\"luci.nacl.toolchain\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"buildnumber\": 4697, \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"buildername\": \"linux-pnacl-x86_64-tests-arm\", \"got_revision\": \"d14a6f6a6be8e9019366d63c3781e3356fe9b3f0\", \"recipe\": \"nacl\", \"mastername\": \"client.nacl.toolchain\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1548300358354743, \"tags\": [\"builder:linux-pnacl-x86_64-tests-arm\", \"buildset:commit/git/d14a6f6a6be8e9019366d63c3781e3356fe9b3f0\", \"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/d14a6f6a6be8e9019366d63c3781e3356fe9b3f0\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9088913181729147808\", \"scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.nacl.toolchain\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"nacl\", \"id\": \"8923483119397082480\"}}, \"slavetype\": \"BuilderTester\", \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"d14a6f6a6be8e9019366d63c3781e3356fe9b3f0\", \"bot_id\": \"gce-trusty-16-145e5bab-us-west1-c-vplb\"}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1548300363499233",
    "status": "COMPLETED",
    "status_changed_ts": "1548309654036980",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4697",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/d14a6f6a6be8e9019366d63c3781e3356fe9b3f0",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/d14a6f6a6be8e9019366d63c3781e3356fe9b3f0",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9088913181729147808",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
      "swarming_dimension:caches:builder_260015d2e489656b9034d382dc1874ce0c1f399ed411416e1867fa173e3e19d1_v2",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.nacl.toolchain",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4697",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8923483119397082480",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-arm",
      "swarming_tag:buildset:commit/git/d14a6f6a6be8e9019366d63c3781e3356fe9b3f0",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/d14a6f6a6be8e9019366d63c3781e3356fe9b3f0",
      "swarming_tag:caches:builder_260015d2e489656b9034d382dc1874ce0c1f399ed411416e1867fa173e3e19d1_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:gitiles_ref:refs/heads/master",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8923483119397082480/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.nacl.toolchain",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9088913181729147808",
      "swarming_tag:scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
      "swarming_tag:service_account:nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:a883ea2343e81ad9b4be8c2424a65260c5b29a9f",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4296b61cd63d9110",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1548309654038362",
    "url": "https://ci.chromium.org/b/8923483119397082480",
    "utcnow_ts": "1548309654384605"
  }
}
[06:00:54.401] Invocation finished in 2h34m57.654876852s with status FAILED