Status: FAILED
Triggered by: -
Duration: 32 minutes
Actions:

Definition (rev 8fecfaafc1abba4843234d58a712c5811f9e1de9)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.nacl.ci"
  builder: "linux_64-newlib-arm_qemu-pnacl-dbg"
>

Incoming triggers

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[20:44:18.886] New invocation is queued and will start shortly
[20:44:20.252] Starting the invocation (attempt 1)
[20:44:20.299] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:44:20.299] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:44:20.299] Buildbucket request:
{
  "bucket": "luci.nacl.ci",
  "client_operation_id": "9094646059071179264",
  "parameters_json": "{\"builder_name\":\"linux_64-newlib-arm_qemu-pnacl-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"55f40a255928a95a71a5c63b37cdf7cc6ec8acae\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux_64-newlib-arm_qemu-pnacl-dbg",
    "scheduler_invocation_id:9094646059071179264",
    "scheduler_job_id:nacl/linux_64-newlib-arm_qemu-pnacl-dbg",
    "user_agent:luci-scheduler",
    "buildset:commit/git/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
    "gitiles_ref:refs/heads/master"
  ]
}
[20:44:22.764] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1542833060423711",
    "id": "8929215996792186144",
    "lease_expiration_ts": "1542951862318065",
    "lease_key": "951072675",
    "parameters_json": "{\"builder_name\": \"linux_64-newlib-arm_qemu-pnacl-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"55f40a255928a95a71a5c63b37cdf7cc6ec8acae\"}}",
    "project": "nacl",
    "result_details_json": "null",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1542833062567868",
    "tags": [
      "build_address:luci.nacl.ci/linux_64-newlib-arm_qemu-pnacl-dbg/81",
      "builder:linux_64-newlib-arm_qemu-pnacl-dbg",
      "buildset:commit/git/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9094646059071179264",
      "scheduler_job_id:nacl/linux_64-newlib-arm_qemu-pnacl-dbg",
      "swarming_dimension:caches:builder_da662c3257abc0b6551de1c232f77ffe4b1f87a95e867a030ad013de4e9ab003_v2",
      "swarming_dimension:cores:8",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.flex.ci",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.nacl.ci/linux_64-newlib-arm_qemu-pnacl-dbg/81",
      "swarming_tag:buildbucket_bucket:nacl/ci",
      "swarming_tag:buildbucket_build_id:8929215996792186144",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:586d78b1df9b356be85f0824ec8364d9ecbabf90",
      "swarming_tag:builder:linux_64-newlib-arm_qemu-pnacl-dbg",
      "swarming_tag:buildset:commit/git/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "swarming_tag:caches:builder_da662c3257abc0b6551de1c232f77ffe4b1f87a95e867a030ad013de4e9ab003_v2",
      "swarming_tag:cores:8",
      "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/8929215996792186144/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.flex.ci",
      "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:9094646059071179264",
      "swarming_tag:scheduler_job_id:nacl/linux_64-newlib-arm_qemu-pnacl-dbg",
      "swarming_tag:service_account:nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:18bb9400d243d9bda9184c768cca1f92d5a22697",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4150d5c68b47ee10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1542833062567968",
    "url": "https://ci.chromium.org/b/8929215996792186144",
    "utcnow_ts": "1542833062746201"
  }
}
[20:44:22.764] Task URL: https://ci.chromium.org/b/8929215996792186144
[20:44:22.764] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:2:0) after 1m0s
[20:44:29.490] Received PubSub notification, asking Buildbucket for the build status
[20:44:29.539] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:22.813] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:2:0)
[20:45:22.813] Timer tick, asking Buildbucket for the build status
[20:45:22.941] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:22.941] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:4:0) after 1m0s
[20:46:22.981] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:4:0)
[20:46:22.981] Timer tick, asking Buildbucket for the build status
[20:46:23.054] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:23.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:5:0) after 1m0s
[20:47:23.346] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:5:0)
[20:47:23.346] Timer tick, asking Buildbucket for the build status
[20:47:23.455] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:23.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:6:0) after 1m0s
[20:48:23.475] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:6:0)
[20:48:23.475] Timer tick, asking Buildbucket for the build status
[20:48:23.512] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:23.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:7:0) after 1m0s
[20:49:23.533] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:7:0)
[20:49:23.533] Timer tick, asking Buildbucket for the build status
[20:49:23.568] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:23.568] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:8:0) after 1m0s
[20:50:23.587] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:8:0)
[20:50:23.587] Timer tick, asking Buildbucket for the build status
[20:50:23.623] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:23.623] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:9:0) after 1m0s
[20:51:23.644] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:9:0)
[20:51:23.644] Timer tick, asking Buildbucket for the build status
[20:51:23.713] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:23.713] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:10:0) after 1m0s
[20:52:23.831] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:10:0)
[20:52:23.831] Timer tick, asking Buildbucket for the build status
[20:52:24.038] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:24.038] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:11:0) after 1m0s
[20:53:24.097] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:11:0)
[20:53:24.097] Timer tick, asking Buildbucket for the build status
[20:53:24.234] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:24.234] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:12:0) after 1m0s
[20:54:24.281] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:12:0)
[20:54:24.281] Timer tick, asking Buildbucket for the build status
[20:54:24.371] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:24.371] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:13:0) after 1m0s
[20:55:24.386] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:13:0)
[20:55:24.386] Timer tick, asking Buildbucket for the build status
[20:55:24.442] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:24.442] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:14:0) after 1m0s
[20:56:24.460] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:14:0)
[20:56:24.460] Timer tick, asking Buildbucket for the build status
[20:56:24.620] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:24.620] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:15:0) after 1m0s
[20:57:24.639] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:15:0)
[20:57:24.639] Timer tick, asking Buildbucket for the build status
[20:57:24.735] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:24.736] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:16:0) after 1m0s
[20:58:24.798] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:16:0)
[20:58:24.798] Timer tick, asking Buildbucket for the build status
[20:58:24.968] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:24.968] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:17:0) after 1m0s
[20:59:25.007] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:17:0)
[20:59:25.007] Timer tick, asking Buildbucket for the build status
[20:59:25.065] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:25.065] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:18:0) after 1m0s
[21:00:25.083] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:18:0)
[21:00:25.083] Timer tick, asking Buildbucket for the build status
[21:00:25.129] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:25.129] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:19:0) after 1m0s
[21:01:25.148] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:19:0)
[21:01:25.148] Timer tick, asking Buildbucket for the build status
[21:01:25.244] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:25.244] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:20:0) after 1m0s
[21:02:25.351] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:20:0)
[21:02:25.351] Timer tick, asking Buildbucket for the build status
[21:02:25.418] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:25.418] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:21:0) after 1m0s
[21:03:25.468] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:21:0)
[21:03:25.468] Timer tick, asking Buildbucket for the build status
[21:03:25.565] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:25.565] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:22:0) after 1m0s
[21:04:25.595] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:22:0)
[21:04:25.595] Timer tick, asking Buildbucket for the build status
[21:04:25.716] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:25.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:23:0) after 1m0s
[21:05:25.736] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:23:0)
[21:05:25.736] Timer tick, asking Buildbucket for the build status
[21:05:25.800] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:25.800] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:24:0) after 1m0s
[21:06:25.883] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:24:0)
[21:06:25.883] Timer tick, asking Buildbucket for the build status
[21:06:25.964] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:25.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:25:0) after 1m0s
[21:07:25.992] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:25:0)
[21:07:25.992] Timer tick, asking Buildbucket for the build status
[21:07:26.087] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:26.087] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:26:0) after 1m0s
[21:08:26.108] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:26:0)
[21:08:26.108] Timer tick, asking Buildbucket for the build status
[21:08:26.186] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:26.186] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:27:0) after 1m0s
[21:09:26.209] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:27:0)
[21:09:26.209] Timer tick, asking Buildbucket for the build status
[21:09:26.291] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:26.291] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:28:0) after 1m0s
[21:10:26.313] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:28:0)
[21:10:26.313] Timer tick, asking Buildbucket for the build status
[21:10:26.476] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:26.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:29:0) after 1m0s
[21:11:26.496] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:29:0)
[21:11:26.496] Timer tick, asking Buildbucket for the build status
[21:11:26.568] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:26.568] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:30:0) after 1m0s
[21:12:26.588] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:30:0)
[21:12:26.588] Timer tick, asking Buildbucket for the build status
[21:12:26.810] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:26.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:31:0) after 1m0s
[21:13:26.843] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:31:0)
[21:13:26.843] Timer tick, asking Buildbucket for the build status
[21:13:26.958] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:26.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:32:0) after 1m0s
[21:14:26.988] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:32:0)
[21:14:26.988] Timer tick, asking Buildbucket for the build status
[21:14:27.158] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:27.158] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:33:0) after 1m0s
[21:15:27.179] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:33:0)
[21:15:27.179] Timer tick, asking Buildbucket for the build status
[21:15:27.264] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:27.264] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:34:0) after 1m0s
[21:16:27.283] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:34:0)
[21:16:27.283] Timer tick, asking Buildbucket for the build status
[21:16:27.476] Build 8929215996792186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:27.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-dbg:9094646059071179264:35:0) after 1m0s
[21:16:54.698] Received PubSub notification, asking Buildbucket for the build status
[21:16:54.755] Build 8929215996792186144: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:16:54.756] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "AUTO",
    "completed_ts": "1542835012844602",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1542833060423711",
    "failure_reason": "BUILD_FAILURE",
    "id": "8929215996792186144",
    "parameters_json": "{\"builder_name\": \"linux_64-newlib-arm_qemu-pnacl-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"55f40a255928a95a71a5c63b37cdf7cc6ec8acae\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"Failure annotated steps\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-golo\", \"us-golo-1\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"kvm\": [\"0\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2670\"], \"server_version\": [\"3874-22d9c44\"], \"machine_type\": [\"n1-highcpu-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"vm316-m1\"], \"pool\": [\"luci.flex.ci\"], \"caches\": [\"builder_30037600afb0fc8938a6d537e3c45a46491e7159df17e0dae8492f75116b87ca_v2\", \"builder_41bff59e48143683eee7e209c35176da7d4c8f0bf6fc4cc531114b3142934c50_v2\", \"builder_49ca5bb4c3d091f43a6ac4e6a8c1974853dc4cb5251f55fae8600b5d6b14c9df_v2\", \"builder_5bf551a0d5d177b55ce526f99d0a6f2ea5c5827f96722dd0bf2e7c331b5e9e59_v2\", \"builder_7ea55abfea25d314356d803a5f0ad62170c3dfd6004ffb0ffd94b75873d1ce3b_v2\", \"builder_b21fc2474b74a202903fba65fd8166899cce4d46f0d8adaea07be83158cf5611_v2\", \"builder_c8e751c405093ae22c3daed2afc711c74e2df07c15bf8f352895d9c637de509d_v2\", \"builder_ef25b88491dc562a084b4a4d622d1da7a429c7f5b0b47ec76bb5145e46035a01_v2\", \"builder_f58e49d4978dd47022c74d62848afbffa29b3ee52aa79f0e76d160631af2bf15_v2\", \"builder_fa9d879aabe313024a0ba592a6a7867dc3149ebafcc9bdcf1ac65c59a572870d_v2\", \"builder_faaedc22e3ac6fec098652e7f0fd10d4f879f8f9ad55ea8ef979585009ee36da_v2\", \"git\", \"goma_v2\", \"infra_gclient_with_go\", \"vpython\"]}}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/mnt/data/b/s/w/ir/cache\", \"temp_dir\": \"/mnt/data/b/s/w/ir/tmp/rt\"}, \"buildnumber\": 81, \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"buildername\": \"linux_64-newlib-arm_qemu-pnacl-dbg\", \"got_revision\": \"55f40a255928a95a71a5c63b37cdf7cc6ec8acae\", \"recipe\": \"nacl\", \"mastername\": \"client.nacl\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1542833060423711, \"tags\": [\"builder:linux_64-newlib-arm_qemu-pnacl-dbg\", \"buildset:commit/git/55f40a255928a95a71a5c63b37cdf7cc6ec8acae\", \"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/55f40a255928a95a71a5c63b37cdf7cc6ec8acae\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9094646059071179264\", \"scheduler_job_id:nacl/linux_64-newlib-arm_qemu-pnacl-dbg\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.nacl.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"nacl\", \"id\": \"8929215996792186144\"}}, \"slavetype\": \"BuilderTester\", \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"55f40a255928a95a71a5c63b37cdf7cc6ec8acae\", \"bot_id\": \"vm316-m1\"}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1542833067848893",
    "status": "COMPLETED",
    "status_changed_ts": "1542835014121119",
    "tags": [
      "build_address:luci.nacl.ci/linux_64-newlib-arm_qemu-pnacl-dbg/81",
      "builder:linux_64-newlib-arm_qemu-pnacl-dbg",
      "buildset:commit/git/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9094646059071179264",
      "scheduler_job_id:nacl/linux_64-newlib-arm_qemu-pnacl-dbg",
      "swarming_dimension:caches:builder_da662c3257abc0b6551de1c232f77ffe4b1f87a95e867a030ad013de4e9ab003_v2",
      "swarming_dimension:cores:8",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.flex.ci",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.nacl.ci/linux_64-newlib-arm_qemu-pnacl-dbg/81",
      "swarming_tag:buildbucket_bucket:nacl/ci",
      "swarming_tag:buildbucket_build_id:8929215996792186144",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:586d78b1df9b356be85f0824ec8364d9ecbabf90",
      "swarming_tag:builder:linux_64-newlib-arm_qemu-pnacl-dbg",
      "swarming_tag:buildset:commit/git/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "swarming_tag:caches:builder_da662c3257abc0b6551de1c232f77ffe4b1f87a95e867a030ad013de4e9ab003_v2",
      "swarming_tag:cores:8",
      "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/8929215996792186144/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.flex.ci",
      "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:9094646059071179264",
      "swarming_tag:scheduler_job_id:nacl/linux_64-newlib-arm_qemu-pnacl-dbg",
      "swarming_tag:service_account:nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:18bb9400d243d9bda9184c768cca1f92d5a22697",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4150d5c68b47ee10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1542835014123598",
    "url": "https://ci.chromium.org/b/8929215996792186144",
    "utcnow_ts": "1542835014745196"
  }
}
[21:16:54.756] Invocation finished in 32m35.88962567s with status FAILED