Status: SUCCEEDED
Triggered by: -
Duration: 44 minutes
Actions:

Definition (rev 8fecfaafc1abba4843234d58a712c5811f9e1de9)

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

Incoming triggers

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[14:44:24.103] New invocation is queued and will start shortly
[14:44:25.168] Starting the invocation (attempt 1)
[14:44:25.238] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:44:25.238] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:44:25.238] Buildbucket request:
{
  "bucket": "luci.nacl.ci",
  "client_operation_id": "9082347515418629824",
  "parameters_json": "{\"builder_name\":\"linux_64-newlib-arm_qemu-pnacl-opt\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"067afa275dcb4b3c6eca979ea5e3fe75073c4080\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux_64-newlib-arm_qemu-pnacl-opt",
    "scheduler_invocation_id:9082347515418629824",
    "scheduler_job_id:nacl/linux_64-newlib-arm_qemu-pnacl-opt",
    "user_agent:luci-scheduler",
    "buildset:commit/git/067afa275dcb4b3c6eca979ea5e3fe75073c4080",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/067afa275dcb4b3c6eca979ea5e3fe75073c4080",
    "gitiles_ref:refs/heads/master"
  ]
}
[14:44:27.280] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "AUTO",
    "created_by": "project:nacl",
    "created_ts": "1554561865334358",
    "id": "8916917453454303648",
    "parameters_json": "{\"builder_name\": \"linux_64-newlib-arm_qemu-pnacl-opt\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"067afa275dcb4b3c6eca979ea5e3fe75073c4080\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1554561866812722",
    "tags": [
      "build_address:luci.nacl.ci/linux_64-newlib-arm_qemu-pnacl-opt/114",
      "builder:linux_64-newlib-arm_qemu-pnacl-opt",
      "buildset:commit/git/067afa275dcb4b3c6eca979ea5e3fe75073c4080",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/067afa275dcb4b3c6eca979ea5e3fe75073c4080",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9082347515418629824",
      "scheduler_job_id:nacl/linux_64-newlib-arm_qemu-pnacl-opt",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8916917453454303648/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1554561866812851",
    "url": "https://ci.chromium.org/b/8916917453454303648",
    "utcnow_ts": "1554561867262638"
  }
}
[14:44:27.280] Task URL: https://ci.chromium.org/b/8916917453454303648
[14:44:27.280] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:2:0) after 1m0s
[14:45:23.507] Received PubSub notification, asking Buildbucket for the build status
[14:45:23.803] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:27.253] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:2:0)
[14:45:27.253] Timer tick, asking Buildbucket for the build status
[14:45:27.371] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:27.371] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:4:0) after 1m0s
[14:46:27.391] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:4:0)
[14:46:27.391] Timer tick, asking Buildbucket for the build status
[14:46:27.520] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:27.520] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:5:0) after 1m0s
[14:47:27.495] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:5:0)
[14:47:27.495] Timer tick, asking Buildbucket for the build status
[14:47:27.579] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:27.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:6:0) after 1m0s
[14:48:27.605] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:6:0)
[14:48:27.605] Timer tick, asking Buildbucket for the build status
[14:48:27.687] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:27.687] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:7:0) after 1m0s
[14:49:27.755] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:7:0)
[14:49:27.755] Timer tick, asking Buildbucket for the build status
[14:49:27.851] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:27.851] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:8:0) after 1m0s
[14:50:27.868] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:8:0)
[14:50:27.868] Timer tick, asking Buildbucket for the build status
[14:50:28.014] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:28.014] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:9:0) after 1m0s
[14:51:28.046] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:9:0)
[14:51:28.046] Timer tick, asking Buildbucket for the build status
[14:51:28.158] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:28.158] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:10:0) after 1m0s
[14:52:28.154] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:10:0)
[14:52:28.154] Timer tick, asking Buildbucket for the build status
[14:52:28.205] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:28.205] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:11:0) after 1m0s
[14:53:28.243] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:11:0)
[14:53:28.243] Timer tick, asking Buildbucket for the build status
[14:53:28.367] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:28.367] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:12:0) after 1m0s
[14:54:28.355] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:12:0)
[14:54:28.355] Timer tick, asking Buildbucket for the build status
[14:54:28.457] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:28.457] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:13:0) after 1m0s
[14:55:28.474] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:13:0)
[14:55:28.474] Timer tick, asking Buildbucket for the build status
[14:55:28.606] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:28.606] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:14:0) after 1m0s
[14:56:28.613] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:14:0)
[14:56:28.613] Timer tick, asking Buildbucket for the build status
[14:56:28.704] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:28.704] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:15:0) after 1m0s
[14:57:28.784] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:15:0)
[14:57:28.784] Timer tick, asking Buildbucket for the build status
[14:57:28.977] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:28.977] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:16:0) after 1m0s
[14:58:29.006] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:16:0)
[14:58:29.006] Timer tick, asking Buildbucket for the build status
[14:58:29.226] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:29.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:17:0) after 1m0s
[14:59:29.244] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:17:0)
[14:59:29.244] Timer tick, asking Buildbucket for the build status
[14:59:29.454] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:29.454] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:18:0) after 1m0s
[15:00:29.434] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:18:0)
[15:00:29.434] Timer tick, asking Buildbucket for the build status
[15:00:29.509] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:29.509] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:19:0) after 1m0s
[15:01:29.505] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:19:0)
[15:01:29.505] Timer tick, asking Buildbucket for the build status
[15:01:29.872] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:29.872] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:20:0) after 1m0s
[15:02:29.887] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:20:0)
[15:02:29.887] Timer tick, asking Buildbucket for the build status
[15:02:29.975] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:29.976] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:21:0) after 1m0s
[15:03:30.017] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:21:0)
[15:03:30.017] Timer tick, asking Buildbucket for the build status
[15:03:30.174] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:30.174] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:22:0) after 1m0s
[15:04:30.191] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:22:0)
[15:04:30.191] Timer tick, asking Buildbucket for the build status
[15:04:30.746] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:30.746] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:23:0) after 1m0s
[15:05:30.767] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:23:0)
[15:05:30.767] Timer tick, asking Buildbucket for the build status
[15:05:31.187] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:31.187] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:24:0) after 1m0s
[15:06:31.238] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:24:0)
[15:06:31.238] Timer tick, asking Buildbucket for the build status
[15:06:31.323] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:31.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:25:0) after 1m0s
[15:07:31.342] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:25:0)
[15:07:31.342] Timer tick, asking Buildbucket for the build status
[15:07:31.423] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:31.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:26:0) after 1m0s
[15:08:31.446] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:26:0)
[15:08:31.446] Timer tick, asking Buildbucket for the build status
[15:08:31.801] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:31.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:27:0) after 1m0s
[15:09:31.794] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:27:0)
[15:09:31.794] Timer tick, asking Buildbucket for the build status
[15:09:31.888] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:31.888] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:28:0) after 1m0s
[15:10:31.906] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:28:0)
[15:10:31.906] Timer tick, asking Buildbucket for the build status
[15:10:32.168] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:32.168] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:29:0) after 1m0s
[15:11:32.210] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:29:0)
[15:11:32.210] Timer tick, asking Buildbucket for the build status
[15:11:32.353] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:32.353] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:30:0) after 1m0s
[15:12:32.372] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:30:0)
[15:12:32.372] Timer tick, asking Buildbucket for the build status
[15:12:32.755] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:32.755] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:31:0) after 1m0s
[15:13:32.740] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:31:0)
[15:13:32.740] Timer tick, asking Buildbucket for the build status
[15:13:32.821] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:32.821] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:32:0) after 1m0s
[15:14:32.841] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:32:0)
[15:14:32.841] Timer tick, asking Buildbucket for the build status
[15:14:33.135] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:33.135] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:33:0) after 1m0s
[15:15:33.187] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:33:0)
[15:15:33.187] Timer tick, asking Buildbucket for the build status
[15:15:33.345] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:33.345] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:34:0) after 1m0s
[15:16:33.373] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:34:0)
[15:16:33.373] Timer tick, asking Buildbucket for the build status
[15:16:33.452] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:33.452] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:35:0) after 1m0s
[15:17:33.472] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:35:0)
[15:17:33.472] Timer tick, asking Buildbucket for the build status
[15:17:33.573] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:33.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:36:0) after 1m0s
[15:18:33.598] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:36:0)
[15:18:33.598] Timer tick, asking Buildbucket for the build status
[15:18:33.700] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:33.700] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:37:0) after 1m0s
[15:19:33.729] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:37:0)
[15:19:33.729] Timer tick, asking Buildbucket for the build status
[15:19:33.951] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:33.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:38:0) after 1m0s
[15:20:33.965] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:38:0)
[15:20:33.965] Timer tick, asking Buildbucket for the build status
[15:20:34.010] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:34.010] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:39:0) after 1m0s
[15:21:34.023] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:39:0)
[15:21:34.023] Timer tick, asking Buildbucket for the build status
[15:21:34.122] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:34.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:40:0) after 1m0s
[15:22:34.149] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:40:0)
[15:22:34.149] Timer tick, asking Buildbucket for the build status
[15:22:34.565] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:34.565] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:41:0) after 1m0s
[15:23:34.594] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:41:0)
[15:23:34.594] Timer tick, asking Buildbucket for the build status
[15:23:34.695] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:34.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:42:0) after 1m0s
[15:24:34.714] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:42:0)
[15:24:34.714] Timer tick, asking Buildbucket for the build status
[15:24:34.852] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:34.852] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:43:0) after 1m0s
[15:25:34.875] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:43:0)
[15:25:34.875] Timer tick, asking Buildbucket for the build status
[15:25:35.063] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:35.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:44:0) after 1m0s
[15:26:35.087] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:44:0)
[15:26:35.087] Timer tick, asking Buildbucket for the build status
[15:26:35.264] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:35.264] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:45:0) after 1m0s
[15:27:35.283] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:45:0)
[15:27:35.283] Timer tick, asking Buildbucket for the build status
[15:27:35.423] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:35.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:46:0) after 1m0s
[15:28:35.456] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:46:0)
[15:28:35.456] Timer tick, asking Buildbucket for the build status
[15:28:35.542] Build 8916917453454303648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:35.542] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-arm_qemu-pnacl-opt:9082347515418629824:47:0) after 1m0s
[15:29:16.015] Received PubSub notification, asking Buildbucket for the build status
[15:29:16.450] Build 8916917453454303648: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:29:16.450] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "AUTO",
    "completed_ts": "1554564555356836",
    "created_by": "project:nacl",
    "created_ts": "1554561865334358",
    "id": "8916917453454303648",
    "parameters_json": "{\"builder_name\": \"linux_64-newlib-arm_qemu-pnacl-opt\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"067afa275dcb4b3c6eca979ea5e3fe75073c4080\"}}",
    "project": "nacl",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-flex-ci-trusty-9-pi8r\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux_64-newlib-arm_qemu-pnacl-opt\", \"buildnumber\": 114, \"got_revision\": \"067afa275dcb4b3c6eca979ea5e3fe75073c4080\", \"mastername\": \"client.nacl\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"067afa275dcb4b3c6eca979ea5e3fe75073c4080\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-flex-ci-trusty-9-pi8r\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.flex.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4243-f38882f\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-a\"]}}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1554561922844378",
    "status": "COMPLETED",
    "status_changed_ts": "1554564555800435",
    "tags": [
      "build_address:luci.nacl.ci/linux_64-newlib-arm_qemu-pnacl-opt/114",
      "builder:linux_64-newlib-arm_qemu-pnacl-opt",
      "buildset:commit/git/067afa275dcb4b3c6eca979ea5e3fe75073c4080",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/067afa275dcb4b3c6eca979ea5e3fe75073c4080",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9082347515418629824",
      "scheduler_job_id:nacl/linux_64-newlib-arm_qemu-pnacl-opt",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8916917453454303648/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Linux",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:440bed28e7a26c10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1554564555807343",
    "url": "https://ci.chromium.org/b/8916917453454303648",
    "utcnow_ts": "1554564556114242"
  }
}
[15:29:16.450] Invocation finished in 44m52.373049331s with status SUCCEEDED