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

Definition (rev 8647dce0c5b1812bd57953fb611ed390e849ac26)

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

Incoming triggers

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[17:00:34.242] New invocation is queued and will start shortly
[17:00:35.415] Starting the invocation (attempt 1)
[17:00:35.470] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:00:35.470] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:00:35.470] Buildbucket request:
{
  "bucket": "luci.nacl.ci",
  "client_operation_id": "9030426886650405552",
  "parameters_json": "{\"builder_name\":\"linux_64-newlib-x86_64-pnacl\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\",\"title\":\"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux_64-newlib-x86_64-pnacl",
    "scheduler_invocation_id:9030426886650405552",
    "scheduler_job_id:nacl/linux_64-newlib-x86_64-pnacl",
    "user_agent:luci-scheduler",
    "buildset:commit/git/f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1",
    "gitiles_ref:refs/heads/master"
  ]
}
[17:00:36.656] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1604077235585174",
    "id": "8864996824577164752",
    "parameters_json": "{\"builder_name\": \"linux_64-newlib-x86_64-pnacl\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"title\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1604077236418129",
    "tags": [
      "build_address:luci.nacl.ci/linux_64-newlib-x86_64-pnacl/167",
      "builder:linux_64-newlib-x86_64-pnacl",
      "buildset:commit/git/f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9030426886650405552",
      "scheduler_job_id:nacl/linux_64-newlib-x86_64-pnacl",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8864996824577164752/+/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": "1604077236418248",
    "url": "https://ci.chromium.org/b/8864996824577164752",
    "utcnow_ts": "1604077236635202"
  }
}
[17:00:36.656] Task URL: https://ci.chromium.org/b/8864996824577164752
[17:00:36.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:2:0) after 1m0s
[17:00:57.642] Received PubSub notification, asking Buildbucket for the build status
[17:00:58.689] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:36.711] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:2:0)
[17:01:36.711] Timer tick, asking Buildbucket for the build status
[17:01:37.087] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:37.087] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:4:0) after 1m0s
[17:02:37.246] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:4:0)
[17:02:37.246] Timer tick, asking Buildbucket for the build status
[17:02:37.404] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:37.404] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:5:0) after 1m0s
[17:03:37.591] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:5:0)
[17:03:37.591] Timer tick, asking Buildbucket for the build status
[17:03:37.725] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:37.725] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:6:0) after 1m0s
[17:04:37.850] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:6:0)
[17:04:37.850] Timer tick, asking Buildbucket for the build status
[17:04:38.030] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:38.030] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:7:0) after 1m0s
[17:05:38.196] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:7:0)
[17:05:38.196] Timer tick, asking Buildbucket for the build status
[17:05:38.284] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:38.284] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:8:0) after 1m0s
[17:06:38.341] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:8:0)
[17:06:38.341] Timer tick, asking Buildbucket for the build status
[17:06:38.824] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:38.824] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:9:0) after 1m0s
[17:07:38.935] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:9:0)
[17:07:38.935] Timer tick, asking Buildbucket for the build status
[17:07:39.001] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:39.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:10:0) after 1m0s
[17:08:39.151] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:10:0)
[17:08:39.151] Timer tick, asking Buildbucket for the build status
[17:08:39.219] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:39.219] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:11:0) after 1m0s
[17:09:39.316] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:11:0)
[17:09:39.316] Timer tick, asking Buildbucket for the build status
[17:09:39.380] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:39.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:12:0) after 1m0s
[17:10:39.463] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:12:0)
[17:10:39.463] Timer tick, asking Buildbucket for the build status
[17:10:39.928] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:39.928] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:13:0) after 1m0s
[17:11:40.012] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:13:0)
[17:11:40.012] Timer tick, asking Buildbucket for the build status
[17:11:40.103] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:40.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:14:0) after 1m0s
[17:12:40.129] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:14:0)
[17:12:40.129] Timer tick, asking Buildbucket for the build status
[17:12:40.202] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:40.202] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:15:0) after 1m0s
[17:13:40.246] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:15:0)
[17:13:40.246] Timer tick, asking Buildbucket for the build status
[17:13:40.315] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:40.315] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:16:0) after 1m0s
[17:14:40.466] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:16:0)
[17:14:40.466] Timer tick, asking Buildbucket for the build status
[17:14:40.563] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:40.563] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:17:0) after 1m0s
[17:15:40.635] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:17:0)
[17:15:40.635] Timer tick, asking Buildbucket for the build status
[17:15:41.213] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:41.213] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:18:0) after 1m0s
[17:16:41.280] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:18:0)
[17:16:41.280] Timer tick, asking Buildbucket for the build status
[17:16:41.518] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:41.518] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:19:0) after 1m0s
[17:17:41.632] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:19:0)
[17:17:41.632] Timer tick, asking Buildbucket for the build status
[17:17:41.792] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:41.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:20:0) after 1m0s
[17:18:41.923] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:20:0)
[17:18:41.923] Timer tick, asking Buildbucket for the build status
[17:18:42.088] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:42.088] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:21:0) after 1m0s
[17:19:42.226] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:21:0)
[17:19:42.226] Timer tick, asking Buildbucket for the build status
[17:19:42.469] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:42.469] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:22:0) after 1m0s
[17:20:42.607] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:22:0)
[17:20:42.607] Timer tick, asking Buildbucket for the build status
[17:20:42.729] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:42.729] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:23:0) after 1m0s
[17:21:42.739] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:23:0)
[17:21:42.739] Timer tick, asking Buildbucket for the build status
[17:21:43.518] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:43.518] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:24:0) after 1m0s
[17:22:43.547] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:24:0)
[17:22:43.547] Timer tick, asking Buildbucket for the build status
[17:22:43.629] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:43.629] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:25:0) after 1m0s
[17:23:43.613] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:25:0)
[17:23:43.613] Timer tick, asking Buildbucket for the build status
[17:23:43.752] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:43.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:26:0) after 1m0s
[17:24:43.827] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:26:0)
[17:24:43.827] Timer tick, asking Buildbucket for the build status
[17:24:44.188] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:44.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:27:0) after 1m0s
[17:25:44.166] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:27:0)
[17:25:44.166] Timer tick, asking Buildbucket for the build status
[17:25:44.484] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:44.484] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:28:0) after 1m0s
[17:26:44.512] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:28:0)
[17:26:44.512] Timer tick, asking Buildbucket for the build status
[17:26:44.695] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:44.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:29:0) after 1m0s
[17:27:44.833] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:29:0)
[17:27:44.833] Timer tick, asking Buildbucket for the build status
[17:27:45.158] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:45.158] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:30:0) after 1m0s
[17:28:45.182] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:30:0)
[17:28:45.182] Timer tick, asking Buildbucket for the build status
[17:28:45.280] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:45.280] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:31:0) after 1m0s
[17:29:45.299] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:31:0)
[17:29:45.299] Timer tick, asking Buildbucket for the build status
[17:29:45.406] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:45.406] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:32:0) after 1m0s
[17:30:45.430] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:32:0)
[17:30:45.430] Timer tick, asking Buildbucket for the build status
[17:30:45.544] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:45.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:33:0) after 1m0s
[17:31:45.570] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:33:0)
[17:31:45.570] Timer tick, asking Buildbucket for the build status
[17:31:45.653] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:45.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:34:0) after 1m0s
[17:32:45.713] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:34:0)
[17:32:45.713] Timer tick, asking Buildbucket for the build status
[17:32:45.819] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:45.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:35:0) after 1m0s
[17:33:45.855] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:35:0)
[17:33:45.855] Timer tick, asking Buildbucket for the build status
[17:33:45.960] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:45.960] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:36:0) after 1m0s
[17:34:45.984] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:36:0)
[17:34:45.984] Timer tick, asking Buildbucket for the build status
[17:34:46.254] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:46.254] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:37:0) after 1m0s
[17:35:46.285] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:37:0)
[17:35:46.285] Timer tick, asking Buildbucket for the build status
[17:35:46.415] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:46.415] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:38:0) after 1m0s
[17:36:46.504] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:38:0)
[17:36:46.504] Timer tick, asking Buildbucket for the build status
[17:36:46.893] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:46.893] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:39:0) after 1m0s
[17:37:47.006] Handling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:39:0)
[17:37:47.006] Timer tick, asking Buildbucket for the build status
[17:37:47.198] Build 8864996824577164752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:47.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux_64-newlib-x86_64-pnacl:9030426886650405552:40:0) after 1m0s
[17:38:01.345] Received PubSub notification, asking Buildbucket for the build status
[17:38:01.474] Build 8864996824577164752: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:38:01.474] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "completed_ts": "1604079480600215",
    "created_by": "project:nacl",
    "created_ts": "1604077235585174",
    "id": "8864996824577164752",
    "parameters_json": "{\"builder_name\": \"linux_64-newlib-x86_64-pnacl\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"title\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\"}}",
    "project": "nacl",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"title\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-flex-ci-xenial-1-9u33\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.nacl\", \"buildername\": \"linux_64-newlib-x86_64-pnacl\", \"buildnumber\": 167, \"got_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-flex-ci-xenial-1-9u33\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.flex.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1604077256868247",
    "status": "COMPLETED",
    "status_changed_ts": "1604079481025148",
    "tags": [
      "build_address:luci.nacl.ci/linux_64-newlib-x86_64-pnacl/167",
      "builder:linux_64-newlib-x86_64-pnacl",
      "buildset:commit/git/f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9030426886650405552",
      "scheduler_job_id:nacl/linux_64-newlib-x86_64-pnacl",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8864996824577164752/+/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:4f9345bcf2c14c10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1604079481036303",
    "url": "https://ci.chromium.org/b/8864996824577164752",
    "utcnow_ts": "1604079481464386"
  }
}
[17:38:01.474] Invocation finished in 37m27.249231375s with status SUCCEEDED