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

• 202ccbd707ded4002aa402b9da0ea4e4026f3a1d (6 years ago)

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

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

[18:17:19.147] New invocation is queued and will start shortly
[18:17:20.655] Starting the invocation (attempt 1)
[18:17:20.733] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:17:20.733] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:17:20.733] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9090759637678147520",
  "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\":\"202ccbd707ded4002aa402b9da0ea4e4026f3a1d\"}}",
  "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:9090759637678147520",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
    "user_agent:luci-scheduler",
    "buildset:commit/git/202ccbd707ded4002aa402b9da0ea4e4026f3a1d",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/202ccbd707ded4002aa402b9da0ea4e4026f3a1d",
    "gitiles_ref:refs/heads/master"
  ]
}
[18:17:21.945] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1546539440842042",
    "id": "8925329575238263376",
    "lease_expiration_ts": "1546690641526542",
    "lease_key": "877724263",
    "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\": \"202ccbd707ded4002aa402b9da0ea4e4026f3a1d\"}}",
    "project": "nacl",
    "result_details_json": "null",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1546539441820827",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4688",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/202ccbd707ded4002aa402b9da0ea4e4026f3a1d",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/202ccbd707ded4002aa402b9da0ea4e4026f3a1d",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9090759637678147520",
      "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/4688",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8925329575238263376",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:daaff082e95b94bec84fa6e440a8b97677d6f76d",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-arm",
      "swarming_tag:buildset:commit/git/202ccbd707ded4002aa402b9da0ea4e4026f3a1d",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/202ccbd707ded4002aa402b9da0ea4e4026f3a1d",
      "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/8925329575238263376/+/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:9090759637678147520",
      "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:8df9132fd2891579a00ae465513e90e9036bee95",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:422dc0a467160310",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1546539441820897",
    "url": "https://ci.chromium.org/b/8925329575238263376",
    "utcnow_ts": "1546539441934883"
  }
}
[18:17:21.945] Task URL: https://ci.chromium.org/b/8925329575238263376
[18:17:21.945] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:2:0) after 1m0s
[18:17:35.173] Received PubSub notification, asking Buildbucket for the build status
[18:17:35.337] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:21.962] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:2:0)
[18:18:21.962] Timer tick, asking Buildbucket for the build status
[18:18:22.048] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:22.048] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:4:0) after 1m0s
[18:19:22.064] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:4:0)
[18:19:22.064] Timer tick, asking Buildbucket for the build status
[18:19:22.495] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:22.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:5:0) after 1m0s
[18:20:22.516] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:5:0)
[18:20:22.516] Timer tick, asking Buildbucket for the build status
[18:20:22.578] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:22.578] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:6:0) after 1m0s
[18:21:22.663] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:6:0)
[18:21:22.663] Timer tick, asking Buildbucket for the build status
[18:21:22.918] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:22.918] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:7:0) after 1m0s
[18:22:22.937] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:7:0)
[18:22:22.938] Timer tick, asking Buildbucket for the build status
[18:22:23.027] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:23.027] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:8:0) after 1m0s
[18:23:23.044] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:8:0)
[18:23:23.044] Timer tick, asking Buildbucket for the build status
[18:23:23.139] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:23.139] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:9:0) after 1m0s
[18:24:23.385] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:9:0)
[18:24:23.385] Timer tick, asking Buildbucket for the build status
[18:24:23.851] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:23.851] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:10:0) after 1m0s
[18:25:24.244] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:10:0)
[18:25:24.244] Timer tick, asking Buildbucket for the build status
[18:25:24.346] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:24.346] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:11:0) after 1m0s
[18:26:24.406] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:11:0)
[18:26:24.406] Timer tick, asking Buildbucket for the build status
[18:26:24.475] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:24.475] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:12:0) after 1m0s
[18:27:24.505] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:12:0)
[18:27:24.505] Timer tick, asking Buildbucket for the build status
[18:27:24.548] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:24.548] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:13:0) after 1m0s
[18:28:24.568] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:13:0)
[18:28:24.568] Timer tick, asking Buildbucket for the build status
[18:28:24.600] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:24.600] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:14:0) after 1m0s
[18:29:24.617] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:14:0)
[18:29:24.617] Timer tick, asking Buildbucket for the build status
[18:29:24.699] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:24.699] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:15:0) after 1m0s
[18:30:24.718] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:15:0)
[18:30:24.718] Timer tick, asking Buildbucket for the build status
[18:30:24.761] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:24.761] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:16:0) after 1m0s
[18:31:24.852] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:16:0)
[18:31:24.852] Timer tick, asking Buildbucket for the build status
[18:31:24.909] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:24.909] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:17:0) after 1m0s
[18:32:24.939] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:17:0)
[18:32:24.939] Timer tick, asking Buildbucket for the build status
[18:32:25.009] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:25.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:18:0) after 1m0s
[18:33:25.046] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:18:0)
[18:33:25.046] Timer tick, asking Buildbucket for the build status
[18:33:25.275] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:25.275] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:19:0) after 1m0s
[18:34:25.294] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:19:0)
[18:34:25.294] Timer tick, asking Buildbucket for the build status
[18:34:25.477] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:25.477] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:20:0) after 1m0s
[18:35:25.495] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:20:0)
[18:35:25.495] Timer tick, asking Buildbucket for the build status
[18:35:25.544] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:25.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:21:0) after 1m0s
[18:36:25.565] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:21:0)
[18:36:25.565] Timer tick, asking Buildbucket for the build status
[18:36:25.599] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:25.599] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:22:0) after 1m0s
[18:37:25.617] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:22:0)
[18:37:25.617] Timer tick, asking Buildbucket for the build status
[18:37:25.710] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:25.710] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:23:0) after 1m0s
[18:38:25.729] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:23:0)
[18:38:25.729] Timer tick, asking Buildbucket for the build status
[18:38:25.799] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:25.799] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:24:0) after 1m0s
[18:39:25.828] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:24:0)
[18:39:25.828] Timer tick, asking Buildbucket for the build status
[18:39:25.887] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:25.887] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:25:0) after 1m0s
[18:40:25.967] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:25:0)
[18:40:25.967] Timer tick, asking Buildbucket for the build status
[18:40:26.115] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:26.115] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:26:0) after 1m0s
[18:41:26.135] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:26:0)
[18:41:26.135] Timer tick, asking Buildbucket for the build status
[18:41:26.188] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:26.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:27:0) after 1m0s
[18:42:26.211] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:27:0)
[18:42:26.211] Timer tick, asking Buildbucket for the build status
[18:42:26.301] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:26.301] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:28:0) after 1m0s
[18:43:26.321] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:28:0)
[18:43:26.321] Timer tick, asking Buildbucket for the build status
[18:43:26.387] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:26.387] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:29:0) after 1m0s
[18:44:26.406] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:29:0)
[18:44:26.406] Timer tick, asking Buildbucket for the build status
[18:44:26.527] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:26.527] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:30:0) after 1m0s
[18:45:26.548] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:30:0)
[18:45:26.548] Timer tick, asking Buildbucket for the build status
[18:45:26.658] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:26.658] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:31:0) after 1m0s
[18:46:26.674] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:31:0)
[18:46:26.674] Timer tick, asking Buildbucket for the build status
[18:46:26.736] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:26.736] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:32:0) after 1m0s
[18:47:26.754] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:32:0)
[18:47:26.754] Timer tick, asking Buildbucket for the build status
[18:47:26.806] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:26.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:33:0) after 1m0s
[18:48:26.823] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:33:0)
[18:48:26.823] Timer tick, asking Buildbucket for the build status
[18:48:26.874] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:26.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:34:0) after 1m0s
[18:49:26.900] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:34:0)
[18:49:26.900] Timer tick, asking Buildbucket for the build status
[18:49:26.948] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:26.948] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:35:0) after 1m0s
[18:50:26.967] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:35:0)
[18:50:26.967] Timer tick, asking Buildbucket for the build status
[18:50:27.027] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:27.028] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:36:0) after 1m0s
[18:51:27.047] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:36:0)
[18:51:27.047] Timer tick, asking Buildbucket for the build status
[18:51:27.211] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:27.211] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:37:0) after 1m0s
[18:52:27.241] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:37:0)
[18:52:27.241] Timer tick, asking Buildbucket for the build status
[18:52:27.306] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:27.306] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:38:0) after 1m0s
[18:53:27.394] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:38:0)
[18:53:27.394] Timer tick, asking Buildbucket for the build status
[18:53:27.453] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:27.453] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:39:0) after 1m0s
[18:54:27.476] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:39:0)
[18:54:27.476] Timer tick, asking Buildbucket for the build status
[18:54:27.535] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:27.535] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:40:0) after 1m0s
[18:55:27.553] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:40:0)
[18:55:27.554] Timer tick, asking Buildbucket for the build status
[18:55:27.634] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:27.634] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:41:0) after 1m0s
[18:56:27.662] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:41:0)
[18:56:27.662] Timer tick, asking Buildbucket for the build status
[18:56:27.707] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:27.707] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:42:0) after 1m0s
[18:57:27.727] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:42:0)
[18:57:27.727] Timer tick, asking Buildbucket for the build status
[18:57:27.814] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:27.814] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:43:0) after 1m0s
[18:58:27.832] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:43:0)
[18:58:27.832] Timer tick, asking Buildbucket for the build status
[18:58:27.971] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:27.971] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:44:0) after 1m0s
[18:59:27.991] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:44:0)
[18:59:27.991] Timer tick, asking Buildbucket for the build status
[18:59:28.031] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:28.031] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:45:0) after 1m0s
[19:00:28.053] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:45:0)
[19:00:28.053] Timer tick, asking Buildbucket for the build status
[19:00:28.170] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:28.170] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:46:0) after 1m0s
[19:01:28.199] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:46:0)
[19:01:28.199] Timer tick, asking Buildbucket for the build status
[19:01:28.270] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:28.270] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:47:0) after 1m0s
[19:02:28.288] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:47:0)
[19:02:28.288] Timer tick, asking Buildbucket for the build status
[19:02:28.344] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:28.344] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:48:0) after 1m0s
[19:03:28.418] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:48:0)
[19:03:28.418] Timer tick, asking Buildbucket for the build status
[19:03:28.466] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:28.466] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:49:0) after 1m0s
[19:04:28.491] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:49:0)
[19:04:28.491] Timer tick, asking Buildbucket for the build status
[19:04:28.652] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:28.652] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:50:0) after 1m0s
[19:05:28.676] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:50:0)
[19:05:28.676] Timer tick, asking Buildbucket for the build status
[19:05:28.745] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:28.745] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:51:0) after 1m0s
[19:06:28.765] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:51:0)
[19:06:28.765] Timer tick, asking Buildbucket for the build status
[19:06:28.817] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:28.817] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:52:0) after 1m0s
[19:07:28.834] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:52:0)
[19:07:28.834] Timer tick, asking Buildbucket for the build status
[19:07:29.008] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:29.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:53:0) after 1m0s
[19:08:29.104] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:53:0)
[19:08:29.104] Timer tick, asking Buildbucket for the build status
[19:08:29.149] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:29.149] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:54:0) after 1m0s
[19:09:29.198] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:54:0)
[19:09:29.198] Timer tick, asking Buildbucket for the build status
[19:09:29.263] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:29.263] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:55:0) after 1m0s
[19:10:29.441] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:55:0)
[19:10:29.441] Timer tick, asking Buildbucket for the build status
[19:10:29.494] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:29.494] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:56:0) after 1m0s
[19:11:29.521] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:56:0)
[19:11:29.521] Timer tick, asking Buildbucket for the build status
[19:11:29.588] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:29.588] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:57:0) after 1m0s
[19:12:29.719] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:57:0)
[19:12:29.719] Timer tick, asking Buildbucket for the build status
[19:12:29.849] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:29.849] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:58:0) after 1m0s
[19:13:29.872] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:58:0)
[19:13:29.872] Timer tick, asking Buildbucket for the build status
[19:13:29.961] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:29.961] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:59:0) after 1m0s
[19:14:29.980] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:59:0)
[19:14:29.980] Timer tick, asking Buildbucket for the build status
[19:14:30.019] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:30.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:60:0) after 1m0s
[19:15:30.109] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:60:0)
[19:15:30.109] Timer tick, asking Buildbucket for the build status
[19:15:30.471] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:30.471] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:61:0) after 1m0s
[19:16:30.501] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:61:0)
[19:16:30.501] Timer tick, asking Buildbucket for the build status
[19:16:30.590] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:30.590] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:62:0) after 1m0s
[19:17:30.614] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:62:0)
[19:17:30.614] Timer tick, asking Buildbucket for the build status
[19:17:30.758] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:30.758] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:63:0) after 1m0s
[19:18:30.786] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:63:0)
[19:18:30.786] Timer tick, asking Buildbucket for the build status
[19:18:30.874] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:30.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:64:0) after 1m0s
[19:19:30.908] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:64:0)
[19:19:30.908] Timer tick, asking Buildbucket for the build status
[19:19:30.961] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:30.961] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:65:0) after 1m0s
[19:20:30.983] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:65:0)
[19:20:30.983] Timer tick, asking Buildbucket for the build status
[19:20:31.080] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:31.080] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:66:0) after 1m0s
[19:21:31.101] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:66:0)
[19:21:31.101] Timer tick, asking Buildbucket for the build status
[19:21:31.198] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:31.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:67:0) after 1m0s
[19:22:31.217] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:67:0)
[19:22:31.217] Timer tick, asking Buildbucket for the build status
[19:22:31.297] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:31.297] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:68:0) after 1m0s
[19:23:31.317] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:68:0)
[19:23:31.317] Timer tick, asking Buildbucket for the build status
[19:23:31.375] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:31.375] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:69:0) after 1m0s
[19:24:31.405] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:69:0)
[19:24:31.405] Timer tick, asking Buildbucket for the build status
[19:24:31.472] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:31.472] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:70:0) after 1m0s
[19:25:31.506] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:70:0)
[19:25:31.506] Timer tick, asking Buildbucket for the build status
[19:25:31.542] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:31.542] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:71:0) after 1m0s
[19:26:31.565] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:71:0)
[19:26:31.565] Timer tick, asking Buildbucket for the build status
[19:26:31.634] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:31.634] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:72:0) after 1m0s
[19:27:31.658] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:72:0)
[19:27:31.658] Timer tick, asking Buildbucket for the build status
[19:27:31.735] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:31.735] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:73:0) after 1m0s
[19:28:31.755] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:73:0)
[19:28:31.755] Timer tick, asking Buildbucket for the build status
[19:28:31.846] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:31.846] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:74:0) after 1m0s
[19:29:31.870] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:74:0)
[19:29:31.870] Timer tick, asking Buildbucket for the build status
[19:29:31.946] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:31.946] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:75:0) after 1m0s
[19:30:31.965] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:75:0)
[19:30:31.965] Timer tick, asking Buildbucket for the build status
[19:30:32.004] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:32.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:76:0) after 1m0s
[19:31:32.027] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:76:0)
[19:31:32.027] Timer tick, asking Buildbucket for the build status
[19:31:32.112] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:32.112] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:77:0) after 1m0s
[19:32:32.222] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:77:0)
[19:32:32.222] Timer tick, asking Buildbucket for the build status
[19:32:32.259] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:32.259] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:78:0) after 1m0s
[19:33:32.278] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:78:0)
[19:33:32.278] Timer tick, asking Buildbucket for the build status
[19:33:32.311] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:32.312] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:79:0) after 1m0s
[19:34:32.390] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:79:0)
[19:34:32.390] Timer tick, asking Buildbucket for the build status
[19:34:32.451] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:32.451] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:80:0) after 1m0s
[19:35:32.470] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:80:0)
[19:35:32.470] Timer tick, asking Buildbucket for the build status
[19:35:32.510] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:32.510] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:81:0) after 1m0s
[19:36:32.539] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:81:0)
[19:36:32.539] Timer tick, asking Buildbucket for the build status
[19:36:32.644] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:32.644] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:82:0) after 1m0s
[19:37:32.755] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:82:0)
[19:37:32.755] Timer tick, asking Buildbucket for the build status
[19:37:32.841] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:32.841] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:83:0) after 1m0s
[19:38:32.878] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:83:0)
[19:38:32.878] Timer tick, asking Buildbucket for the build status
[19:38:33.001] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:33.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:84:0) after 1m0s
[19:39:33.042] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:84:0)
[19:39:33.042] Timer tick, asking Buildbucket for the build status
[19:39:33.081] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:33.081] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:85:0) after 1m0s
[19:40:33.106] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:85:0)
[19:40:33.106] Timer tick, asking Buildbucket for the build status
[19:40:33.153] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:33.153] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:86:0) after 1m0s
[19:41:33.173] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:86:0)
[19:41:33.173] Timer tick, asking Buildbucket for the build status
[19:41:33.278] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:33.278] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:87:0) after 1m0s
[19:42:33.431] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:87:0)
[19:42:33.431] Timer tick, asking Buildbucket for the build status
[19:42:33.549] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:33.549] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:88:0) after 1m0s
[19:43:33.578] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:88:0)
[19:43:33.578] Timer tick, asking Buildbucket for the build status
[19:43:33.617] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:33.617] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:89:0) after 1m0s
[19:44:33.638] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:89:0)
[19:44:33.638] Timer tick, asking Buildbucket for the build status
[19:44:33.694] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:33.694] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:90:0) after 1m0s
[19:45:33.721] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:90:0)
[19:45:33.721] Timer tick, asking Buildbucket for the build status
[19:45:33.799] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:33.799] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:91:0) after 1m0s
[19:46:33.841] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:91:0)
[19:46:33.841] Timer tick, asking Buildbucket for the build status
[19:46:33.981] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:33.981] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:92:0) after 1m0s
[19:47:34.002] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:92:0)
[19:47:34.002] Timer tick, asking Buildbucket for the build status
[19:47:34.063] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:34.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:93:0) after 1m0s
[19:48:34.088] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:93:0)
[19:48:34.088] Timer tick, asking Buildbucket for the build status
[19:48:34.130] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:34.130] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:94:0) after 1m0s
[19:49:34.247] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:94:0)
[19:49:34.247] Timer tick, asking Buildbucket for the build status
[19:49:34.331] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:34.331] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:95:0) after 1m0s
[19:50:34.455] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:95:0)
[19:50:34.455] Timer tick, asking Buildbucket for the build status
[19:50:34.510] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:34.510] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:96:0) after 1m0s
[19:51:34.533] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:96:0)
[19:51:34.533] Timer tick, asking Buildbucket for the build status
[19:51:34.631] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:34.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:97:0) after 1m0s
[19:52:34.651] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:97:0)
[19:52:34.651] Timer tick, asking Buildbucket for the build status
[19:52:34.693] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:34.693] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:98:0) after 1m0s
[19:53:34.736] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:98:0)
[19:53:34.736] Timer tick, asking Buildbucket for the build status
[19:53:34.819] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:34.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:99:0) after 1m0s
[19:54:34.842] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:99:0)
[19:54:34.842] Timer tick, asking Buildbucket for the build status
[19:54:34.914] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:34.914] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:100:0) after 1m0s
[19:55:34.940] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:100:0)
[19:55:34.940] Timer tick, asking Buildbucket for the build status
[19:55:34.979] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:34.979] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:101:0) after 1m0s
[19:56:35.008] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:101:0)
[19:56:35.008] Timer tick, asking Buildbucket for the build status
[19:56:35.105] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:35.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:102:0) after 1m0s
[19:57:35.125] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:102:0)
[19:57:35.125] Timer tick, asking Buildbucket for the build status
[19:57:35.162] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:35.162] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:103:0) after 1m0s
[19:58:35.207] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:103:0)
[19:58:35.207] Timer tick, asking Buildbucket for the build status
[19:58:35.239] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:35.239] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:104:0) after 1m0s
[19:59:35.279] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:104:0)
[19:59:35.279] Timer tick, asking Buildbucket for the build status
[19:59:35.327] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:35.327] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:105:0) after 1m0s
[20:00:35.410] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:105:0)
[20:00:35.410] Timer tick, asking Buildbucket for the build status
[20:00:35.467] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:35.467] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:106:0) after 1m0s
[20:01:35.517] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:106:0)
[20:01:35.517] Timer tick, asking Buildbucket for the build status
[20:01:35.575] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:35.575] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:107:0) after 1m0s
[20:02:35.711] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:107:0)
[20:02:35.711] Timer tick, asking Buildbucket for the build status
[20:02:35.757] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:35.757] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:108:0) after 1m0s
[20:03:35.778] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:108:0)
[20:03:35.778] Timer tick, asking Buildbucket for the build status
[20:03:36.141] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:36.141] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:109:0) after 1m0s
[20:04:36.163] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:109:0)
[20:04:36.163] Timer tick, asking Buildbucket for the build status
[20:04:36.260] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:36.260] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:110:0) after 1m0s
[20:05:36.330] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:110:0)
[20:05:36.330] Timer tick, asking Buildbucket for the build status
[20:05:36.374] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:36.374] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:111:0) after 1m0s
[20:06:36.397] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:111:0)
[20:06:36.397] Timer tick, asking Buildbucket for the build status
[20:06:36.544] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:36.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:112:0) after 1m0s
[20:07:36.569] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:112:0)
[20:07:36.569] Timer tick, asking Buildbucket for the build status
[20:07:36.630] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:36.630] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:113:0) after 1m0s
[20:08:36.651] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:113:0)
[20:08:36.651] Timer tick, asking Buildbucket for the build status
[20:08:36.898] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:36.898] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:114:0) after 1m0s
[20:09:36.920] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:114:0)
[20:09:36.920] Timer tick, asking Buildbucket for the build status
[20:09:37.059] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:37.059] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:115:0) after 1m0s
[20:10:37.079] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:115:0)
[20:10:37.079] Timer tick, asking Buildbucket for the build status
[20:10:37.329] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:37.329] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:116:0) after 1m0s
[20:11:37.361] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:116:0)
[20:11:37.361] Timer tick, asking Buildbucket for the build status
[20:11:37.403] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:37.403] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:117:0) after 1m0s
[20:12:37.425] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:117:0)
[20:12:37.425] Timer tick, asking Buildbucket for the build status
[20:12:37.461] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:37.461] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:118:0) after 1m0s
[20:13:37.551] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:118:0)
[20:13:37.551] Timer tick, asking Buildbucket for the build status
[20:13:37.715] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:37.715] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:119:0) after 1m0s
[20:14:37.735] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:119:0)
[20:14:37.735] Timer tick, asking Buildbucket for the build status
[20:14:37.802] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:37.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:120:0) after 1m0s
[20:15:37.839] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:120:0)
[20:15:37.839] Timer tick, asking Buildbucket for the build status
[20:15:37.961] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:37.961] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:121:0) after 1m0s
[20:16:37.987] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:121:0)
[20:16:37.987] Timer tick, asking Buildbucket for the build status
[20:16:38.038] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:38.038] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:122:0) after 1m0s
[20:17:38.059] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:122:0)
[20:17:38.059] Timer tick, asking Buildbucket for the build status
[20:17:38.098] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:38.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:123:0) after 1m0s
[20:18:38.124] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:123:0)
[20:18:38.124] Timer tick, asking Buildbucket for the build status
[20:18:38.203] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:38.203] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:124:0) after 1m0s
[20:19:38.258] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:124:0)
[20:19:38.258] Timer tick, asking Buildbucket for the build status
[20:19:38.298] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:38.298] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:125:0) after 1m0s
[20:20:38.325] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:125:0)
[20:20:38.325] Timer tick, asking Buildbucket for the build status
[20:20:38.393] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:38.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:126:0) after 1m0s
[20:21:38.414] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:126:0)
[20:21:38.414] Timer tick, asking Buildbucket for the build status
[20:21:38.521] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:38.521] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:127:0) after 1m0s
[20:22:38.565] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:127:0)
[20:22:38.565] Timer tick, asking Buildbucket for the build status
[20:22:38.604] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:38.604] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:128:0) after 1m0s
[20:23:38.626] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:128:0)
[20:23:38.626] Timer tick, asking Buildbucket for the build status
[20:23:38.773] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:38.773] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:129:0) after 1m0s
[20:24:38.818] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:129:0)
[20:24:38.818] Timer tick, asking Buildbucket for the build status
[20:24:38.879] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:38.879] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:130:0) after 1m0s
[20:25:38.900] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:130:0)
[20:25:38.900] Timer tick, asking Buildbucket for the build status
[20:25:38.968] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:38.968] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:131:0) after 1m0s
[20:26:38.996] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:131:0)
[20:26:38.996] Timer tick, asking Buildbucket for the build status
[20:26:39.029] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:39.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:132:0) after 1m0s
[20:27:39.117] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:132:0)
[20:27:39.117] Timer tick, asking Buildbucket for the build status
[20:27:39.192] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:39.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:133:0) after 1m0s
[20:28:39.219] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:133:0)
[20:28:39.219] Timer tick, asking Buildbucket for the build status
[20:28:39.280] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:39.280] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:134:0) after 1m0s
[20:29:39.330] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:134:0)
[20:29:39.330] Timer tick, asking Buildbucket for the build status
[20:29:39.467] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:39.467] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:135:0) after 1m0s
[20:30:39.499] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:135:0)
[20:30:39.499] Timer tick, asking Buildbucket for the build status
[20:30:39.546] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:39.546] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:136:0) after 1m0s
[20:31:39.576] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:136:0)
[20:31:39.576] Timer tick, asking Buildbucket for the build status
[20:31:39.618] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:39.618] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:137:0) after 1m0s
[20:32:39.690] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:137:0)
[20:32:39.690] Timer tick, asking Buildbucket for the build status
[20:32:39.803] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:39.803] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:138:0) after 1m0s
[20:33:39.834] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:138:0)
[20:33:39.834] Timer tick, asking Buildbucket for the build status
[20:33:39.891] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:39.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:139:0) after 1m0s
[20:34:39.915] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:139:0)
[20:34:39.915] Timer tick, asking Buildbucket for the build status
[20:34:39.959] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:39.959] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:140:0) after 1m0s
[20:35:39.990] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:140:0)
[20:35:39.990] Timer tick, asking Buildbucket for the build status
[20:35:40.144] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:40.144] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:141:0) after 1m0s
[20:36:40.177] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:141:0)
[20:36:40.177] Timer tick, asking Buildbucket for the build status
[20:36:40.321] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:40.321] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:142:0) after 1m0s
[20:37:40.345] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:142:0)
[20:37:40.345] Timer tick, asking Buildbucket for the build status
[20:37:40.411] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:40.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:143:0) after 1m0s
[20:38:40.435] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:143:0)
[20:38:40.435] Timer tick, asking Buildbucket for the build status
[20:38:40.484] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:40.484] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:144:0) after 1m0s
[20:39:40.504] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:144:0)
[20:39:40.504] Timer tick, asking Buildbucket for the build status
[20:39:40.551] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:40.551] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:145:0) after 1m0s
[20:40:40.579] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:145:0)
[20:40:40.579] Timer tick, asking Buildbucket for the build status
[20:40:40.639] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:40.639] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:146:0) after 1m0s
[20:41:40.741] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:146:0)
[20:41:40.741] Timer tick, asking Buildbucket for the build status
[20:41:40.787] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:40.787] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:147:0) after 1m0s
[20:42:40.812] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:147:0)
[20:42:40.812] Timer tick, asking Buildbucket for the build status
[20:42:40.876] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:40.876] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:148:0) after 1m0s
[20:43:40.954] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:148:0)
[20:43:40.954] Timer tick, asking Buildbucket for the build status
[20:43:41.012] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:41.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:149:0) after 1m0s
[20:44:41.072] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:149:0)
[20:44:41.072] Timer tick, asking Buildbucket for the build status
[20:44:41.162] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:41.162] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:150:0) after 1m0s
[20:45:41.182] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:150:0)
[20:45:41.182] Timer tick, asking Buildbucket for the build status
[20:45:41.277] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:41.277] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:151:0) after 1m0s
[20:46:41.300] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:151:0)
[20:46:41.300] Timer tick, asking Buildbucket for the build status
[20:46:41.368] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:41.368] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:152:0) after 1m0s
[20:47:41.424] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:152:0)
[20:47:41.424] Timer tick, asking Buildbucket for the build status
[20:47:41.530] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:41.530] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:153:0) after 1m0s
[20:48:41.638] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:153:0)
[20:48:41.638] Timer tick, asking Buildbucket for the build status
[20:48:41.680] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:41.680] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:154:0) after 1m0s
[20:49:41.715] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:154:0)
[20:49:41.715] Timer tick, asking Buildbucket for the build status
[20:49:41.777] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:41.777] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:155:0) after 1m0s
[20:50:41.801] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:155:0)
[20:50:41.801] Timer tick, asking Buildbucket for the build status
[20:50:41.930] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:41.930] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:156:0) after 1m0s
[20:51:41.951] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:156:0)
[20:51:41.951] Timer tick, asking Buildbucket for the build status
[20:51:42.059] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:42.059] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:157:0) after 1m0s
[20:52:42.114] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:157:0)
[20:52:42.114] Timer tick, asking Buildbucket for the build status
[20:52:42.158] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:42.158] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:158:0) after 1m0s
[20:53:42.185] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:158:0)
[20:53:42.185] Timer tick, asking Buildbucket for the build status
[20:53:42.297] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:42.297] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:159:0) after 1m0s
[20:54:42.369] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:159:0)
[20:54:42.369] Timer tick, asking Buildbucket for the build status
[20:54:42.475] Build 8925329575238263376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:42.475] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9090759637678147520:160:0) after 1m0s
[20:54:49.748] Received PubSub notification, asking Buildbucket for the build status
[20:54:49.866] Build 8925329575238263376: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:54:49.866] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "completed_ts": "1546548888246000",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1546539440842042",
    "failure_reason": "BUILD_FAILURE",
    "id": "8925329575238263376",
    "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\": \"202ccbd707ded4002aa402b9da0ea4e4026f3a1d\"}}",
    "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\": [\"3945-402d3be\"], \"machine_type\": [\"n1-standard-16\"], \"gpu\": [\"none\"], \"cores\": [\"16\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-16-145e5bab-us-west1-c-46hp\"], \"pool\": [\"luci.nacl.toolchain\"]}}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"buildnumber\": 4688, \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"buildername\": \"linux-pnacl-x86_64-tests-arm\", \"got_revision\": \"202ccbd707ded4002aa402b9da0ea4e4026f3a1d\", \"recipe\": \"nacl\", \"mastername\": \"client.nacl.toolchain\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1546539440842042, \"tags\": [\"builder:linux-pnacl-x86_64-tests-arm\", \"buildset:commit/git/202ccbd707ded4002aa402b9da0ea4e4026f3a1d\", \"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/202ccbd707ded4002aa402b9da0ea4e4026f3a1d\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9090759637678147520\", \"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\": \"8925329575238263376\"}}, \"slavetype\": \"BuilderTester\", \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"202ccbd707ded4002aa402b9da0ea4e4026f3a1d\", \"bot_id\": \"gce-trusty-16-145e5bab-us-west1-c-46hp\"}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1546539454284637",
    "status": "COMPLETED",
    "status_changed_ts": "1546548889372691",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4688",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/202ccbd707ded4002aa402b9da0ea4e4026f3a1d",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/202ccbd707ded4002aa402b9da0ea4e4026f3a1d",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9090759637678147520",
      "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/4688",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8925329575238263376",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:daaff082e95b94bec84fa6e440a8b97677d6f76d",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-arm",
      "swarming_tag:buildset:commit/git/202ccbd707ded4002aa402b9da0ea4e4026f3a1d",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/202ccbd707ded4002aa402b9da0ea4e4026f3a1d",
      "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/8925329575238263376/+/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:9090759637678147520",
      "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:8df9132fd2891579a00ae465513e90e9036bee95",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:422dc0a467160310",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1546548889373899",
    "url": "https://ci.chromium.org/b/8925329575238263376",
    "utcnow_ts": "1546548889841301"
  }
}
[20:54:49.866] Invocation finished in 2h37m30.735020542s with status FAILED