[18:34:01.124] New invocation is queued and will start shortly
[18:34:02.546] Starting the invocation (attempt 1)
[18:34:02.610] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:34:02.610] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:34:02.610] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9055063382274499776",
"parameters_json": "{\"builder_name\":\"gcc-arm64-linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/binutils-2_34-branch\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/binutils-2_34-branch@d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\",\"title\":\"d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\"},{\"gitiles\":{\"ref\":\"refs/heads/binutils-2_34-branch\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"871ac467f59d9df1a911d29126d93a3014898e15\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/binutils-2_34-branch@871ac467f59d9df1a911d29126d93a3014898e15\",\"title\":\"871ac467f59d9df1a911d29126d93a3014898e15\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/871ac467f59d9df1a911d29126d93a3014898e15\"}]},\"branch\":\"refs/heads/binutils-2_34-branch\",\"repository\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"871ac467f59d9df1a911d29126d93a3014898e15\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-arm64-linux",
"scheduler_invocation_id:9055063382274499776",
"scheduler_job_id:fuchsia/prod-gcc-arm64-linux",
"user_agent:luci-scheduler",
"buildset:commit/git/871ac467f59d9df1a911d29126d93a3014898e15",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/871ac467f59d9df1a911d29126d93a3014898e15",
"gitiles_ref:refs/heads/binutils-2_34-branch"
]
}
[18:34:03.377] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1580582042811854",
"id": "8889633319835401856",
"parameters_json": "{\"builder_name\": \"gcc-arm64-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/binutils-2_34-branch\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/binutils-2_34-branch@d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\", \"title\": \"d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\"}, {\"gitiles\": {\"ref\": \"refs/heads/binutils-2_34-branch\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"871ac467f59d9df1a911d29126d93a3014898e15\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/binutils-2_34-branch@871ac467f59d9df1a911d29126d93a3014898e15\", \"title\": \"871ac467f59d9df1a911d29126d93a3014898e15\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/871ac467f59d9df1a911d29126d93a3014898e15\"}]}, \"branch\": \"refs/heads/binutils-2_34-branch\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"871ac467f59d9df1a911d29126d93a3014898e15\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580582043161301",
"tags": [
"builder:gcc-arm64-linux",
"buildset:commit/git/871ac467f59d9df1a911d29126d93a3014898e15",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/871ac467f59d9df1a911d29126d93a3014898e15",
"gitiles_ref:refs/heads/binutils-2_34-branch",
"scheduler_invocation_id:9055063382274499776",
"scheduler_job_id:fuchsia/prod-gcc-arm64-linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/fuchsia/buildbucket/cr-buildbucket.appspot.com/8889633319835401856/+/annotations",
"swarming_tag:luci_project:fuchsia",
"swarming_tag:recipe_name:gcc_toolchain",
"swarming_tag:recipe_package:fuchsia/infra/recipe_bundles/fuchsia.googlesource.com/infra/recipes",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1580582043161462",
"url": "https://ci.chromium.org/b/8889633319835401856",
"utcnow_ts": "1580582043368020"
}
}
[18:34:03.377] Task URL: https://ci.chromium.org/b/8889633319835401856
[18:34:03.377] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:2:0) after 1m0s
[18:34:46.424] Received PubSub notification, asking Buildbucket for the build status
[18:34:46.588] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:03.354] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:2:0)
[18:35:03.354] Timer tick, asking Buildbucket for the build status
[18:35:03.482] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:03.482] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:4:0) after 1m0s
[18:36:03.498] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:4:0)
[18:36:03.498] Timer tick, asking Buildbucket for the build status
[18:36:03.647] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:03.647] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:5:0) after 1m0s
[18:37:03.711] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:5:0)
[18:37:03.711] Timer tick, asking Buildbucket for the build status
[18:37:05.203] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:05.203] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:6:0) after 1m0s
[18:38:05.220] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:6:0)
[18:38:05.220] Timer tick, asking Buildbucket for the build status
[18:38:05.344] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:05.344] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:7:0) after 1m0s
[18:39:05.367] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:7:0)
[18:39:05.367] Timer tick, asking Buildbucket for the build status
[18:39:05.750] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:05.750] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:8:0) after 1m0s
[18:40:06.074] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:8:0)
[18:40:06.074] Timer tick, asking Buildbucket for the build status
[18:40:06.473] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:06.473] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:9:0) after 1m0s
[18:41:06.511] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:9:0)
[18:41:06.511] Timer tick, asking Buildbucket for the build status
[18:41:06.977] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:06.977] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:10:0) after 1m0s
[18:42:07.002] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:10:0)
[18:42:07.002] Timer tick, asking Buildbucket for the build status
[18:42:07.392] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:07.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:11:0) after 1m0s
[18:43:07.431] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:11:0)
[18:43:07.431] Timer tick, asking Buildbucket for the build status
[18:43:07.525] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:07.525] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:12:0) after 1m0s
[18:44:07.523] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:12:0)
[18:44:07.523] Timer tick, asking Buildbucket for the build status
[18:44:07.665] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:07.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:13:0) after 1m0s
[18:45:07.693] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:13:0)
[18:45:07.693] Timer tick, asking Buildbucket for the build status
[18:45:07.813] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:07.813] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:14:0) after 1m0s
[18:46:07.832] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:14:0)
[18:46:07.832] Timer tick, asking Buildbucket for the build status
[18:46:07.967] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:07.967] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:15:0) after 1m0s
[18:47:08.038] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:15:0)
[18:47:08.038] Timer tick, asking Buildbucket for the build status
[18:47:08.178] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:08.178] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:16:0) after 1m0s
[18:48:08.203] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:16:0)
[18:48:08.203] Timer tick, asking Buildbucket for the build status
[18:48:08.416] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:08.416] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:17:0) after 1m0s
[18:49:08.463] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:17:0)
[18:49:08.463] Timer tick, asking Buildbucket for the build status
[18:49:08.575] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:08.575] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:18:0) after 1m0s
[18:50:08.595] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:18:0)
[18:50:08.595] Timer tick, asking Buildbucket for the build status
[18:50:08.835] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:08.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:19:0) after 1m0s
[18:51:08.851] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:19:0)
[18:51:08.851] Timer tick, asking Buildbucket for the build status
[18:51:08.963] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:08.963] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:20:0) after 1m0s
[18:52:09.003] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:20:0)
[18:52:09.003] Timer tick, asking Buildbucket for the build status
[18:52:09.195] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:09.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:21:0) after 1m0s
[18:53:09.279] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:21:0)
[18:53:09.279] Timer tick, asking Buildbucket for the build status
[18:53:09.588] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:09.588] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:22:0) after 1m0s
[18:54:09.606] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:22:0)
[18:54:09.606] Timer tick, asking Buildbucket for the build status
[18:54:09.873] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:09.873] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:23:0) after 1m0s
[18:55:09.953] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:23:0)
[18:55:09.953] Timer tick, asking Buildbucket for the build status
[18:55:10.233] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:10.233] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:24:0) after 1m0s
[18:56:10.255] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:24:0)
[18:56:10.255] Timer tick, asking Buildbucket for the build status
[18:56:10.395] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:10.395] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:25:0) after 1m0s
[18:57:10.444] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:25:0)
[18:57:10.444] Timer tick, asking Buildbucket for the build status
[18:57:10.686] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:10.686] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:26:0) after 1m0s
[18:58:10.812] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:26:0)
[18:58:10.812] Timer tick, asking Buildbucket for the build status
[18:58:10.903] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:10.903] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:27:0) after 1m0s
[18:59:10.912] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:27:0)
[18:59:10.912] Timer tick, asking Buildbucket for the build status
[18:59:11.026] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:11.026] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:28:0) after 1m0s
[19:00:11.048] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:28:0)
[19:00:11.048] Timer tick, asking Buildbucket for the build status
[19:00:11.164] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:11.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:29:0) after 1m0s
[19:01:11.184] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:29:0)
[19:01:11.184] Timer tick, asking Buildbucket for the build status
[19:01:11.294] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:11.294] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:30:0) after 1m0s
[19:02:11.437] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:30:0)
[19:02:11.437] Timer tick, asking Buildbucket for the build status
[19:02:11.550] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:11.550] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:31:0) after 1m0s
[19:03:12.134] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:31:0)
[19:03:12.134] Timer tick, asking Buildbucket for the build status
[19:03:12.248] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:12.248] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:32:0) after 1m0s
[19:04:12.507] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:32:0)
[19:04:12.507] Timer tick, asking Buildbucket for the build status
[19:04:12.649] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:12.649] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:33:0) after 1m0s
[19:05:12.666] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:33:0)
[19:05:12.666] Timer tick, asking Buildbucket for the build status
[19:05:12.829] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:12.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:34:0) after 1m0s
[19:06:12.952] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:34:0)
[19:06:12.952] Timer tick, asking Buildbucket for the build status
[19:06:13.893] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:13.893] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:35:0) after 1m0s
[19:07:13.989] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:35:0)
[19:07:13.989] Timer tick, asking Buildbucket for the build status
[19:07:14.349] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:14.349] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:36:0) after 1m0s
[19:08:14.413] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:36:0)
[19:08:14.413] Timer tick, asking Buildbucket for the build status
[19:08:14.779] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:14.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:37:0) after 1m0s
[19:09:14.789] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:37:0)
[19:09:14.789] Timer tick, asking Buildbucket for the build status
[19:09:14.898] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:14.898] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:38:0) after 1m0s
[19:10:14.966] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:38:0)
[19:10:14.966] Timer tick, asking Buildbucket for the build status
[19:10:15.076] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:15.076] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:39:0) after 1m0s
[19:11:15.100] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:39:0)
[19:11:15.100] Timer tick, asking Buildbucket for the build status
[19:11:15.254] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:15.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:40:0) after 1m0s
[19:12:15.284] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:40:0)
[19:12:15.284] Timer tick, asking Buildbucket for the build status
[19:12:15.408] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:15.408] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:41:0) after 1m0s
[19:13:15.432] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:41:0)
[19:13:15.432] Timer tick, asking Buildbucket for the build status
[19:13:15.531] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:15.531] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:42:0) after 1m0s
[19:14:15.556] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:42:0)
[19:14:15.556] Timer tick, asking Buildbucket for the build status
[19:14:15.835] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:15.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:43:0) after 1m0s
[19:15:15.860] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:43:0)
[19:15:15.860] Timer tick, asking Buildbucket for the build status
[19:15:16.601] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:16.601] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:44:0) after 1m0s
[19:16:16.635] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:44:0)
[19:16:16.635] Timer tick, asking Buildbucket for the build status
[19:16:16.726] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:16.726] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:45:0) after 1m0s
[19:17:16.747] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:45:0)
[19:17:16.747] Timer tick, asking Buildbucket for the build status
[19:17:16.972] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:16.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:46:0) after 1m0s
[19:18:16.998] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:46:0)
[19:18:16.998] Timer tick, asking Buildbucket for the build status
[19:18:17.124] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:17.124] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:47:0) after 1m0s
[19:19:17.141] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:47:0)
[19:19:17.141] Timer tick, asking Buildbucket for the build status
[19:19:17.351] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:17.351] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:48:0) after 1m0s
[19:20:17.395] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:48:0)
[19:20:17.395] Timer tick, asking Buildbucket for the build status
[19:20:17.763] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:17.763] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:49:0) after 1m0s
[19:21:17.781] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:49:0)
[19:21:17.781] Timer tick, asking Buildbucket for the build status
[19:21:17.891] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:17.891] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:50:0) after 1m0s
[19:22:18.118] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:50:0)
[19:22:18.118] Timer tick, asking Buildbucket for the build status
[19:22:18.218] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:18.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:51:0) after 1m0s
[19:23:18.295] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:51:0)
[19:23:18.295] Timer tick, asking Buildbucket for the build status
[19:23:18.779] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:18.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:52:0) after 1m0s
[19:24:18.797] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:52:0)
[19:24:18.797] Timer tick, asking Buildbucket for the build status
[19:24:18.923] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:18.923] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:53:0) after 1m0s
[19:25:18.986] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:53:0)
[19:25:18.986] Timer tick, asking Buildbucket for the build status
[19:25:19.369] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:19.369] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:54:0) after 1m0s
[19:26:19.428] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:54:0)
[19:26:19.428] Timer tick, asking Buildbucket for the build status
[19:26:19.527] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:19.527] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:55:0) after 1m0s
[19:27:19.638] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:55:0)
[19:27:19.638] Timer tick, asking Buildbucket for the build status
[19:27:19.942] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:19.942] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:56:0) after 1m0s
[19:28:19.963] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:56:0)
[19:28:19.963] Timer tick, asking Buildbucket for the build status
[19:28:20.367] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:20.367] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:57:0) after 1m0s
[19:29:20.387] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:57:0)
[19:29:20.387] Timer tick, asking Buildbucket for the build status
[19:29:20.563] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:20.563] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:58:0) after 1m0s
[19:30:20.657] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:58:0)
[19:30:20.657] Timer tick, asking Buildbucket for the build status
[19:30:20.938] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:20.938] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:59:0) after 1m0s
[19:31:21.049] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:59:0)
[19:31:21.049] Timer tick, asking Buildbucket for the build status
[19:31:21.288] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:21.288] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:60:0) after 1m0s
[19:32:21.359] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:60:0)
[19:32:21.359] Timer tick, asking Buildbucket for the build status
[19:32:21.944] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:21.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:61:0) after 1m0s
[19:33:22.199] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:61:0)
[19:33:22.199] Timer tick, asking Buildbucket for the build status
[19:33:22.351] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:22.351] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:62:0) after 1m0s
[19:34:22.653] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:62:0)
[19:34:22.653] Timer tick, asking Buildbucket for the build status
[19:34:23.127] Build 8889633319835401856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:23.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9055063382274499776:63:0) after 1m0s
[19:34:45.397] Received PubSub notification, asking Buildbucket for the build status
[19:34:45.482] Build 8889633319835401856: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:34:45.482] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1580585684489495",
"created_by": "project:fuchsia",
"created_ts": "1580582042811854",
"id": "8889633319835401856",
"parameters_json": "{\"builder_name\": \"gcc-arm64-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/binutils-2_34-branch\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/binutils-2_34-branch@d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\", \"title\": \"d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\"}, {\"gitiles\": {\"ref\": \"refs/heads/binutils-2_34-branch\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"871ac467f59d9df1a911d29126d93a3014898e15\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/binutils-2_34-branch@871ac467f59d9df1a911d29126d93a3014898e15\", \"title\": \"871ac467f59d9df1a911d29126d93a3014898e15\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/871ac467f59d9df1a911d29126d93a3014898e15\"}]}, \"branch\": \"refs/heads/binutils-2_34-branch\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"871ac467f59d9df1a911d29126d93a3014898e15\"}}",
"project": "fuchsia",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$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/binutils-2_34-branch\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/binutils-2_34-branch@d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\", \"title\": \"d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/d7f734bc7e9e5fb6c33b433973b57e1eed3a7e9f\"}, {\"gitiles\": {\"ref\": \"refs/heads/binutils-2_34-branch\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"871ac467f59d9df1a911d29126d93a3014898e15\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/binutils-2_34-branch@871ac467f59d9df1a911d29126d93a3014898e15\", \"title\": \"871ac467f59d9df1a911d29126d93a3014898e15\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/871ac467f59d9df1a911d29126d93a3014898e15\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"build414-a9\", \"branch\": \"refs/heads/binutils-2_34-branch\", \"buildername\": \"gcc-arm64-linux\", \"instance_id\": \"D9sJTbyHcnr13-xXFmZkao5VIgX5-Xh4wbS3tOGoe_gC\", \"isolated\": \"c5bac88b9fd1ec30cb1961fb5df47a52df1304a0\", \"mastername\": \"gcc\", \"package\": \"fuchsia/third_party/gcc/linux-arm64\", \"path_config\": \"generic\", \"recipe\": \"gcc_toolchain\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"871ac467f59d9df1a911d29126d93a3014898e15\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"git\", \"vpython\"], \"cores\": [\"256\"], \"cpu\": [\"arm\", \"arm-64\", \"arm64\", \"arm64-64\"], \"gce\": [\"0\"], \"gpu\": [\"1a03\", \"1a03:2000\"], \"id\": [\"build414-a9\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-highcpu-16\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-18.04\"], \"pool\": [\"luci.fuchsia.prod\"], \"python\": [\"2.7.15+\"], \"server_version\": [\"4804-5c544e0\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-mtv\", \"us-mtv-chops\", \"us-mtv-chops-a9\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1580582085583505",
"status": "COMPLETED",
"status_changed_ts": "1580585684803313",
"tags": [
"builder:gcc-arm64-linux",
"buildset:commit/git/871ac467f59d9df1a911d29126d93a3014898e15",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/871ac467f59d9df1a911d29126d93a3014898e15",
"gitiles_ref:refs/heads/binutils-2_34-branch",
"scheduler_invocation_id:9055063382274499776",
"scheduler_job_id:fuchsia/prod-gcc-arm64-linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/fuchsia/buildbucket/cr-buildbucket.appspot.com/8889633319835401856/+/annotations",
"swarming_tag:luci_project:fuchsia",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:gcc_toolchain",
"swarming_tag:recipe_package:fuchsia/infra/recipe_bundles/fuchsia.googlesource.com/infra/recipes",
"swarming_task_id:4a1ad988e4128410",
"user_agent:luci-scheduler"
],
"updated_ts": "1580585684816623",
"url": "https://ci.chromium.org/b/8889633319835401856",
"utcnow_ts": "1580585685471258"
}
}
[19:34:45.482] Invocation finished in 1h0m44.379598374s with status SUCCEEDED