[13:46:12.216] New invocation is queued and will start shortly
[13:46:13.283] Starting the invocation (attempt 1)
[13:46:13.316] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:46:13.316] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:46:13.316] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9056168653627384480",
"parameters_json": "{\"builder_name\":\"gcc-arm64-linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/releases/gcc-9\",\"repo\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"42066149461d7e6951d61c341954b0ed77c08d34\"},\"id\":\"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@42066149461d7e6951d61c341954b0ed77c08d34\",\"title\":\"42066149461d7e6951d61c341954b0ed77c08d34\",\"url\":\"https://gnu.googlesource.com/gcc/+/42066149461d7e6951d61c341954b0ed77c08d34\"}]},\"branch\":\"refs/heads/releases/gcc-9\",\"repository\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"42066149461d7e6951d61c341954b0ed77c08d34\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-arm64-linux",
"scheduler_invocation_id:9056168653627384480",
"scheduler_job_id:fuchsia/prod-gcc-arm64-linux",
"user_agent:luci-scheduler",
"buildset:commit/git/42066149461d7e6951d61c341954b0ed77c08d34",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/42066149461d7e6951d61c341954b0ed77c08d34",
"gitiles_ref:refs/heads/releases/gcc-9"
]
}
[13:46:14.168] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1579527973460849",
"id": "8890738591659106400",
"parameters_json": "{\"builder_name\": \"gcc-arm64-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"42066149461d7e6951d61c341954b0ed77c08d34\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@42066149461d7e6951d61c341954b0ed77c08d34\", \"title\": \"42066149461d7e6951d61c341954b0ed77c08d34\", \"url\": \"https://gnu.googlesource.com/gcc/+/42066149461d7e6951d61c341954b0ed77c08d34\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"42066149461d7e6951d61c341954b0ed77c08d34\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1579527973698074",
"tags": [
"builder:gcc-arm64-linux",
"buildset:commit/git/42066149461d7e6951d61c341954b0ed77c08d34",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/42066149461d7e6951d61c341954b0ed77c08d34",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9056168653627384480",
"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/8890738591659106400/+/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": "1579527973698185",
"url": "https://ci.chromium.org/b/8890738591659106400",
"utcnow_ts": "1579527974153776"
}
}
[13:46:14.168] Task URL: https://ci.chromium.org/b/8890738591659106400
[13:46:14.168] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:2:0) after 1m0s
[13:46:15.228] Received PubSub notification, asking Buildbucket for the build status
[13:46:15.391] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:14.243] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:2:0)
[13:47:14.243] Timer tick, asking Buildbucket for the build status
[13:47:14.574] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:14.574] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:4:0) after 1m0s
[13:48:14.636] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:4:0)
[13:48:14.636] Timer tick, asking Buildbucket for the build status
[13:48:14.804] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:14.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:5:0) after 1m0s
[13:49:14.775] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:5:0)
[13:49:14.775] Timer tick, asking Buildbucket for the build status
[13:49:14.998] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:14.998] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:6:0) after 1m0s
[13:50:15.188] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:6:0)
[13:50:15.188] Timer tick, asking Buildbucket for the build status
[13:50:15.485] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:15.485] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:7:0) after 1m0s
[13:51:15.520] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:7:0)
[13:51:15.520] Timer tick, asking Buildbucket for the build status
[13:51:15.683] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:15.683] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:8:0) after 1m0s
[13:52:15.748] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:8:0)
[13:52:15.748] Timer tick, asking Buildbucket for the build status
[13:52:15.861] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:15.861] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:9:0) after 1m0s
[13:53:15.877] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:9:0)
[13:53:15.877] Timer tick, asking Buildbucket for the build status
[13:53:16.334] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:16.334] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:10:0) after 1m0s
[13:54:16.382] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:10:0)
[13:54:16.382] Timer tick, asking Buildbucket for the build status
[13:54:16.449] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:16.449] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:11:0) after 1m0s
[13:55:16.467] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:11:0)
[13:55:16.467] Timer tick, asking Buildbucket for the build status
[13:55:16.865] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:16.866] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:12:0) after 1m0s
[13:56:16.914] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:12:0)
[13:56:16.914] Timer tick, asking Buildbucket for the build status
[13:56:17.221] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:17.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:13:0) after 1m0s
[13:57:17.267] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:13:0)
[13:57:17.268] Timer tick, asking Buildbucket for the build status
[13:57:17.345] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:17.345] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:14:0) after 1m0s
[13:58:17.364] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:14:0)
[13:58:17.364] Timer tick, asking Buildbucket for the build status
[13:58:17.447] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:17.447] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:15:0) after 1m0s
[13:59:17.495] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:15:0)
[13:59:17.495] Timer tick, asking Buildbucket for the build status
[13:59:17.627] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:17.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:16:0) after 1m0s
[14:00:17.705] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:16:0)
[14:00:17.705] Timer tick, asking Buildbucket for the build status
[14:00:17.914] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:17.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:17:0) after 1m0s
[14:01:17.951] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:17:0)
[14:01:17.951] Timer tick, asking Buildbucket for the build status
[14:01:18.095] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:18.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:18:0) after 1m0s
[14:02:18.243] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:18:0)
[14:02:18.243] Timer tick, asking Buildbucket for the build status
[14:02:18.355] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:18.355] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:19:0) after 1m0s
[14:03:18.470] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:19:0)
[14:03:18.470] Timer tick, asking Buildbucket for the build status
[14:03:18.611] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:18.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:20:0) after 1m0s
[14:04:18.821] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:20:0)
[14:04:18.821] Timer tick, asking Buildbucket for the build status
[14:04:19.263] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:19.263] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:21:0) after 1m0s
[14:05:19.451] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:21:0)
[14:05:19.451] Timer tick, asking Buildbucket for the build status
[14:05:19.602] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:19.602] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:22:0) after 1m0s
[14:06:19.825] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:22:0)
[14:06:19.825] Timer tick, asking Buildbucket for the build status
[14:06:19.966] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:19.966] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:23:0) after 1m0s
[14:07:20.008] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:23:0)
[14:07:20.008] Timer tick, asking Buildbucket for the build status
[14:07:20.158] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:20.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:24:0) after 1m0s
[14:08:20.195] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:24:0)
[14:08:20.195] Timer tick, asking Buildbucket for the build status
[14:08:20.896] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:20.896] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:25:0) after 1m0s
[14:09:20.972] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:25:0)
[14:09:20.972] Timer tick, asking Buildbucket for the build status
[14:09:21.102] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:21.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:26:0) after 1m0s
[14:10:21.164] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:26:0)
[14:10:21.164] Timer tick, asking Buildbucket for the build status
[14:10:21.285] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:21.285] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:27:0) after 1m0s
[14:11:21.313] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:27:0)
[14:11:21.313] Timer tick, asking Buildbucket for the build status
[14:11:21.511] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:21.511] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:28:0) after 1m0s
[14:12:21.570] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:28:0)
[14:12:21.570] Timer tick, asking Buildbucket for the build status
[14:12:21.938] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:21.938] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:29:0) after 1m0s
[14:13:21.957] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:29:0)
[14:13:21.957] Timer tick, asking Buildbucket for the build status
[14:13:22.086] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:22.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:30:0) after 1m0s
[14:14:22.113] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:30:0)
[14:14:22.113] Timer tick, asking Buildbucket for the build status
[14:14:22.216] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:22.216] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:31:0) after 1m0s
[14:15:22.248] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:31:0)
[14:15:22.248] Timer tick, asking Buildbucket for the build status
[14:15:22.467] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:22.467] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:32:0) after 1m0s
[14:16:22.450] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:32:0)
[14:16:22.450] Timer tick, asking Buildbucket for the build status
[14:16:22.549] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:22.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:33:0) after 1m0s
[14:17:22.603] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:33:0)
[14:17:22.603] Timer tick, asking Buildbucket for the build status
[14:17:22.721] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:22.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:34:0) after 1m0s
[14:18:22.753] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:34:0)
[14:18:22.753] Timer tick, asking Buildbucket for the build status
[14:18:23.021] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:23.021] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:35:0) after 1m0s
[14:19:23.047] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:35:0)
[14:19:23.047] Timer tick, asking Buildbucket for the build status
[14:19:23.165] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:23.165] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:36:0) after 1m0s
[14:20:23.188] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:36:0)
[14:20:23.188] Timer tick, asking Buildbucket for the build status
[14:20:23.318] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:23.318] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:37:0) after 1m0s
[14:21:23.430] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:37:0)
[14:21:23.430] Timer tick, asking Buildbucket for the build status
[14:21:23.591] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:23.591] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:38:0) after 1m0s
[14:22:23.675] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:38:0)
[14:22:23.675] Timer tick, asking Buildbucket for the build status
[14:22:23.881] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:23.881] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:39:0) after 1m0s
[14:23:23.915] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:39:0)
[14:23:23.915] Timer tick, asking Buildbucket for the build status
[14:23:24.018] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:24.018] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:40:0) after 1m0s
[14:24:24.342] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:40:0)
[14:24:24.342] Timer tick, asking Buildbucket for the build status
[14:24:24.626] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:24.626] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:41:0) after 1m0s
[14:25:24.746] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:41:0)
[14:25:24.746] Timer tick, asking Buildbucket for the build status
[14:25:25.187] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:25.187] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:42:0) after 1m0s
[14:26:25.292] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:42:0)
[14:26:25.292] Timer tick, asking Buildbucket for the build status
[14:26:25.434] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:25.434] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:43:0) after 1m0s
[14:27:25.637] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:43:0)
[14:27:25.637] Timer tick, asking Buildbucket for the build status
[14:27:26.119] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:26.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:44:0) after 1m0s
[14:28:26.194] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:44:0)
[14:28:26.194] Timer tick, asking Buildbucket for the build status
[14:28:26.251] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:26.251] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:45:0) after 1m0s
[14:29:26.492] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:45:0)
[14:29:26.492] Timer tick, asking Buildbucket for the build status
[14:29:26.907] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:26.907] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:46:0) after 1m0s
[14:30:26.995] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:46:0)
[14:30:26.995] Timer tick, asking Buildbucket for the build status
[14:30:27.081] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:27.081] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:47:0) after 1m0s
[14:31:27.211] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:47:0)
[14:31:27.211] Timer tick, asking Buildbucket for the build status
[14:31:27.335] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:27.335] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:48:0) after 1m0s
[14:32:27.395] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:48:0)
[14:32:27.395] Timer tick, asking Buildbucket for the build status
[14:32:27.773] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:27.773] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:49:0) after 1m0s
[14:33:27.794] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:49:0)
[14:33:27.794] Timer tick, asking Buildbucket for the build status
[14:33:27.988] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:27.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:50:0) after 1m0s
[14:34:28.005] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:50:0)
[14:34:28.005] Timer tick, asking Buildbucket for the build status
[14:34:28.128] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:28.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:51:0) after 1m0s
[14:35:28.152] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:51:0)
[14:35:28.152] Timer tick, asking Buildbucket for the build status
[14:35:28.995] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:28.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:52:0) after 1m0s
[14:36:29.021] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:52:0)
[14:36:29.021] Timer tick, asking Buildbucket for the build status
[14:36:30.463] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:30.463] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:53:0) after 1m0s
[14:37:30.497] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:53:0)
[14:37:30.497] Timer tick, asking Buildbucket for the build status
[14:37:30.676] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:30.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:54:0) after 1m0s
[14:38:30.725] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:54:0)
[14:38:30.725] Timer tick, asking Buildbucket for the build status
[14:38:30.832] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:30.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:55:0) after 1m0s
[14:39:30.951] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:55:0)
[14:39:30.951] Timer tick, asking Buildbucket for the build status
[14:39:31.351] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:31.351] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:56:0) after 1m0s
[14:40:31.378] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:56:0)
[14:40:31.378] Timer tick, asking Buildbucket for the build status
[14:40:31.622] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:31.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:57:0) after 1m0s
[14:41:31.644] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:57:0)
[14:41:31.645] Timer tick, asking Buildbucket for the build status
[14:41:31.835] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:31.836] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:58:0) after 1m0s
[14:42:31.920] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:58:0)
[14:42:31.920] Timer tick, asking Buildbucket for the build status
[14:42:32.364] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:32.364] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:59:0) after 1m0s
[14:43:32.377] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:59:0)
[14:43:32.377] Timer tick, asking Buildbucket for the build status
[14:43:32.770] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:32.770] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:60:0) after 1m0s
[14:44:32.854] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:60:0)
[14:44:32.854] Timer tick, asking Buildbucket for the build status
[14:44:32.962] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:32.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:61:0) after 1m0s
[14:45:33.119] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:61:0)
[14:45:33.119] Timer tick, asking Buildbucket for the build status
[14:45:33.347] Build 8890738591659106400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:33.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9056168653627384480:62:0) after 1m0s
[14:46:12.111] Received PubSub notification, asking Buildbucket for the build status
[14:46:14.722] Build 8890738591659106400: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:46:14.722] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1579531570990109",
"created_by": "project:fuchsia",
"created_ts": "1579527973460849",
"id": "8890738591659106400",
"parameters_json": "{\"builder_name\": \"gcc-arm64-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"42066149461d7e6951d61c341954b0ed77c08d34\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@42066149461d7e6951d61c341954b0ed77c08d34\", \"title\": \"42066149461d7e6951d61c341954b0ed77c08d34\", \"url\": \"https://gnu.googlesource.com/gcc/+/42066149461d7e6951d61c341954b0ed77c08d34\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"42066149461d7e6951d61c341954b0ed77c08d34\"}}",
"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/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"42066149461d7e6951d61c341954b0ed77c08d34\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@42066149461d7e6951d61c341954b0ed77c08d34\", \"title\": \"42066149461d7e6951d61c341954b0ed77c08d34\", \"url\": \"https://gnu.googlesource.com/gcc/+/42066149461d7e6951d61c341954b0ed77c08d34\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"build414-a9\", \"branch\": \"refs/heads/releases/gcc-9\", \"buildername\": \"gcc-arm64-linux\", \"instance_id\": \"ECzX-xJYyKzYqVpr1wPQgoD6pv4Ap2hOw8s_X8TdmDkC\", \"isolated\": \"94893c6495b20477895b92801e6a2ba424abe1f9\", \"mastername\": \"gcc\", \"package\": \"fuchsia/third_party/gcc/linux-arm64\", \"path_config\": \"generic\", \"recipe\": \"gcc_toolchain\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"42066149461d7e6951d61c341954b0ed77c08d34\"}, \"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\": [\"4784-e3296b5\"], \"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": "1579527974607271",
"status": "COMPLETED",
"status_changed_ts": "1579531571465499",
"tags": [
"builder:gcc-arm64-linux",
"buildset:commit/git/42066149461d7e6951d61c341954b0ed77c08d34",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/42066149461d7e6951d61c341954b0ed77c08d34",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9056168653627384480",
"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/8890738591659106400/+/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:49dc05b58e392110",
"user_agent:luci-scheduler"
],
"updated_ts": "1579531571580818",
"url": "https://ci.chromium.org/b/8890738591659106400",
"utcnow_ts": "1579531574702081"
}
}
[14:46:14.722] Invocation finished in 1h0m2.522223192s with status SUCCEEDED