[14:44:19.418] New invocation is queued and will start shortly
[14:44:21.376] Starting the invocation (attempt 1)
[14:44:21.409] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:44:21.409] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:44:21.409] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9052994103208688464",
"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\":\"8389fcc4c1253fe11fd310284dcf31ac6c02a749\"},\"id\":\"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@8389fcc4c1253fe11fd310284dcf31ac6c02a749\",\"title\":\"8389fcc4c1253fe11fd310284dcf31ac6c02a749\",\"url\":\"https://gnu.googlesource.com/gcc/+/8389fcc4c1253fe11fd310284dcf31ac6c02a749\"}]},\"branch\":\"refs/heads/releases/gcc-9\",\"repository\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"8389fcc4c1253fe11fd310284dcf31ac6c02a749\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-arm64-linux",
"scheduler_invocation_id:9052994103208688464",
"scheduler_job_id:fuchsia/prod-gcc-arm64-linux",
"user_agent:luci-scheduler",
"buildset:commit/git/8389fcc4c1253fe11fd310284dcf31ac6c02a749",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/8389fcc4c1253fe11fd310284dcf31ac6c02a749",
"gitiles_ref:refs/heads/releases/gcc-9"
]
}
[14:44:22.115] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:fuchsia",
"created_ts": "1582555461515778",
"id": "8887564040345042160",
"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\": \"8389fcc4c1253fe11fd310284dcf31ac6c02a749\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@8389fcc4c1253fe11fd310284dcf31ac6c02a749\", \"title\": \"8389fcc4c1253fe11fd310284dcf31ac6c02a749\", \"url\": \"https://gnu.googlesource.com/gcc/+/8389fcc4c1253fe11fd310284dcf31ac6c02a749\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"8389fcc4c1253fe11fd310284dcf31ac6c02a749\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582555461920810",
"tags": [
"builder:gcc-arm64-linux",
"buildset:commit/git/8389fcc4c1253fe11fd310284dcf31ac6c02a749",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/8389fcc4c1253fe11fd310284dcf31ac6c02a749",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9052994103208688464",
"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/8887564040345042160/+/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": "1582555461921014",
"url": "https://ci.chromium.org/b/8887564040345042160",
"utcnow_ts": "1582555462098938"
}
}
[14:44:22.115] Task URL: https://ci.chromium.org/b/8887564040345042160
[14:44:22.115] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:2:0) after 1m0s
[14:44:24.635] Received PubSub notification, asking Buildbucket for the build status
[14:44:24.736] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:22.140] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:2:0)
[14:45:22.140] Timer tick, asking Buildbucket for the build status
[14:45:22.403] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:22.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:4:0) after 1m0s
[14:46:22.495] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:4:0)
[14:46:22.495] Timer tick, asking Buildbucket for the build status
[14:46:22.734] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:22.734] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:5:0) after 1m0s
[14:47:22.751] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:5:0)
[14:47:22.751] Timer tick, asking Buildbucket for the build status
[14:47:23.025] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:23.025] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:6:0) after 1m0s
[14:48:23.047] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:6:0)
[14:48:23.047] Timer tick, asking Buildbucket for the build status
[14:48:23.632] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:23.632] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:7:0) after 1m0s
[14:49:23.616] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:7:0)
[14:49:23.616] Timer tick, asking Buildbucket for the build status
[14:49:23.846] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:23.846] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:8:0) after 1m0s
[14:50:23.837] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:8:0)
[14:50:23.837] Timer tick, asking Buildbucket for the build status
[14:50:23.964] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:23.964] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:9:0) after 1m0s
[14:51:23.985] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:9:0)
[14:51:23.985] Timer tick, asking Buildbucket for the build status
[14:51:24.314] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:24.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:10:0) after 1m0s
[14:52:24.290] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:10:0)
[14:52:24.290] Timer tick, asking Buildbucket for the build status
[14:52:24.390] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:24.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:11:0) after 1m0s
[14:53:24.478] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:11:0)
[14:53:24.478] Timer tick, asking Buildbucket for the build status
[14:53:24.601] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:24.601] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:12:0) after 1m0s
[14:54:24.653] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:12:0)
[14:54:24.653] Timer tick, asking Buildbucket for the build status
[14:54:24.744] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:24.744] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:13:0) after 1m0s
[14:55:24.899] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:13:0)
[14:55:24.899] Timer tick, asking Buildbucket for the build status
[14:55:25.012] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:25.012] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:14:0) after 1m0s
[14:56:25.094] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:14:0)
[14:56:25.094] Timer tick, asking Buildbucket for the build status
[14:56:25.244] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:25.244] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:15:0) after 1m0s
[14:57:25.376] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:15:0)
[14:57:25.376] Timer tick, asking Buildbucket for the build status
[14:57:25.632] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:25.633] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:16:0) after 1m0s
[14:58:25.683] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:16:0)
[14:58:25.683] Timer tick, asking Buildbucket for the build status
[14:58:25.790] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:25.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:17:0) after 1m0s
[14:59:25.842] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:17:0)
[14:59:25.842] Timer tick, asking Buildbucket for the build status
[14:59:25.941] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:25.941] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:18:0) after 1m0s
[15:00:25.977] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:18:0)
[15:00:25.977] Timer tick, asking Buildbucket for the build status
[15:00:26.077] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:26.077] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:19:0) after 1m0s
[15:01:26.152] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:19:0)
[15:01:26.152] Timer tick, asking Buildbucket for the build status
[15:01:26.568] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:26.568] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:20:0) after 1m0s
[15:02:26.620] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:20:0)
[15:02:26.620] Timer tick, asking Buildbucket for the build status
[15:02:26.748] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:26.748] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:21:0) after 1m0s
[15:03:26.804] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:21:0)
[15:03:26.804] Timer tick, asking Buildbucket for the build status
[15:03:27.009] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:27.009] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:22:0) after 1m0s
[15:04:27.115] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:22:0)
[15:04:27.115] Timer tick, asking Buildbucket for the build status
[15:04:27.409] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:27.409] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:23:0) after 1m0s
[15:05:27.452] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:23:0)
[15:05:27.452] Timer tick, asking Buildbucket for the build status
[15:05:27.584] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:27.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:24:0) after 1m0s
[15:06:27.591] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:24:0)
[15:06:27.591] Timer tick, asking Buildbucket for the build status
[15:06:27.712] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:27.712] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:25:0) after 1m0s
[15:07:27.746] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:25:0)
[15:07:27.746] Timer tick, asking Buildbucket for the build status
[15:07:27.944] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:27.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:26:0) after 1m0s
[15:08:27.974] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:26:0)
[15:08:27.974] Timer tick, asking Buildbucket for the build status
[15:08:28.195] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:28.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:27:0) after 1m0s
[15:09:28.181] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:27:0)
[15:09:28.181] Timer tick, asking Buildbucket for the build status
[15:09:28.749] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:28.749] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:28:0) after 1m0s
[15:10:28.962] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:28:0)
[15:10:28.962] Timer tick, asking Buildbucket for the build status
[15:10:29.405] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:29.405] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:29:0) after 1m0s
[15:11:29.461] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:29:0)
[15:11:29.461] Timer tick, asking Buildbucket for the build status
[15:11:29.589] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:29.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:30:0) after 1m0s
[15:12:29.726] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:30:0)
[15:12:29.726] Timer tick, asking Buildbucket for the build status
[15:12:29.985] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:29.985] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:31:0) after 1m0s
[15:13:30.018] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:31:0)
[15:13:30.018] Timer tick, asking Buildbucket for the build status
[15:13:30.144] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:30.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:32:0) after 1m0s
[15:14:30.250] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:32:0)
[15:14:30.250] Timer tick, asking Buildbucket for the build status
[15:14:30.360] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:30.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:33:0) after 1m0s
[15:15:30.459] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:33:0)
[15:15:30.459] Timer tick, asking Buildbucket for the build status
[15:15:30.623] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:30.623] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:34:0) after 1m0s
[15:16:30.671] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:34:0)
[15:16:30.671] Timer tick, asking Buildbucket for the build status
[15:16:30.924] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:30.924] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:35:0) after 1m0s
[15:17:31.006] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:35:0)
[15:17:31.006] Timer tick, asking Buildbucket for the build status
[15:17:31.288] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:31.288] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:36:0) after 1m0s
[15:18:31.473] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:36:0)
[15:18:31.473] Timer tick, asking Buildbucket for the build status
[15:18:31.810] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:31.810] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:37:0) after 1m0s
[15:19:31.928] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:37:0)
[15:19:31.928] Timer tick, asking Buildbucket for the build status
[15:19:32.097] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:32.097] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:38:0) after 1m0s
[15:20:32.234] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:38:0)
[15:20:32.234] Timer tick, asking Buildbucket for the build status
[15:20:32.550] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:32.550] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:39:0) after 1m0s
[15:21:32.700] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:39:0)
[15:21:32.700] Timer tick, asking Buildbucket for the build status
[15:21:33.637] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:33.637] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:40:0) after 1m0s
[15:22:37.349] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:40:0)
[15:22:37.349] Timer tick, asking Buildbucket for the build status
[15:22:37.457] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:37.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:41:0) after 1m0s
[15:23:37.742] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:41:0)
[15:23:37.742] Timer tick, asking Buildbucket for the build status
[15:23:37.894] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:37.894] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:42:0) after 1m0s
[15:24:38.831] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:42:0)
[15:24:38.831] Timer tick, asking Buildbucket for the build status
[15:24:39.354] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:39.354] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:43:0) after 1m0s
[15:25:42.373] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:43:0)
[15:25:42.373] Timer tick, asking Buildbucket for the build status
[15:25:42.549] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:42.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:44:0) after 1m0s
[15:26:42.576] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:44:0)
[15:26:42.576] Timer tick, asking Buildbucket for the build status
[15:26:42.829] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:42.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:45:0) after 1m0s
[15:27:42.863] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:45:0)
[15:27:42.863] Timer tick, asking Buildbucket for the build status
[15:27:43.098] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:43.098] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:46:0) after 1m0s
[15:28:43.118] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:46:0)
[15:28:43.118] Timer tick, asking Buildbucket for the build status
[15:28:43.313] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:43.313] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:47:0) after 1m0s
[15:29:43.335] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:47:0)
[15:29:43.335] Timer tick, asking Buildbucket for the build status
[15:29:43.492] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:43.492] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:48:0) after 1m0s
[15:30:43.532] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:48:0)
[15:30:43.532] Timer tick, asking Buildbucket for the build status
[15:30:43.622] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:43.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:49:0) after 1m0s
[15:31:43.623] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:49:0)
[15:31:43.623] Timer tick, asking Buildbucket for the build status
[15:31:43.744] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:43.744] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:50:0) after 1m0s
[15:32:43.769] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:50:0)
[15:32:43.769] Timer tick, asking Buildbucket for the build status
[15:32:43.884] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:43.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:51:0) after 1m0s
[15:33:43.935] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:51:0)
[15:33:43.935] Timer tick, asking Buildbucket for the build status
[15:33:44.065] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:44.065] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:52:0) after 1m0s
[15:34:44.088] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:52:0)
[15:34:44.088] Timer tick, asking Buildbucket for the build status
[15:34:44.267] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:44.267] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:53:0) after 1m0s
[15:35:44.383] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:53:0)
[15:35:44.383] Timer tick, asking Buildbucket for the build status
[15:35:44.566] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:44.566] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:54:0) after 1m0s
[15:36:44.602] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:54:0)
[15:36:44.602] Timer tick, asking Buildbucket for the build status
[15:36:44.736] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:44.736] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:55:0) after 1m0s
[15:37:44.775] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:55:0)
[15:37:44.775] Timer tick, asking Buildbucket for the build status
[15:37:46.475] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:46.475] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:56:0) after 1m0s
[15:38:46.533] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:56:0)
[15:38:46.533] Timer tick, asking Buildbucket for the build status
[15:38:46.669] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:46.669] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:57:0) after 1m0s
[15:39:46.735] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:57:0)
[15:39:46.735] Timer tick, asking Buildbucket for the build status
[15:39:46.945] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:46.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:58:0) after 1m0s
[15:40:47.002] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:58:0)
[15:40:47.002] Timer tick, asking Buildbucket for the build status
[15:40:47.143] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:47.143] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:59:0) after 1m0s
[15:41:47.209] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:59:0)
[15:41:47.209] Timer tick, asking Buildbucket for the build status
[15:41:47.332] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:47.332] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:60:0) after 1m0s
[15:42:47.356] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:60:0)
[15:42:47.356] Timer tick, asking Buildbucket for the build status
[15:42:47.637] Build 8887564040345042160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:47.637] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052994103208688464:61:0) after 1m0s
[15:42:58.457] Received PubSub notification, asking Buildbucket for the build status
[15:42:58.612] Build 8887564040345042160: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:42:58.612] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1582558977895749",
"created_by": "project:fuchsia",
"created_ts": "1582555461515778",
"id": "8887564040345042160",
"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\": \"8389fcc4c1253fe11fd310284dcf31ac6c02a749\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@8389fcc4c1253fe11fd310284dcf31ac6c02a749\", \"title\": \"8389fcc4c1253fe11fd310284dcf31ac6c02a749\", \"url\": \"https://gnu.googlesource.com/gcc/+/8389fcc4c1253fe11fd310284dcf31ac6c02a749\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"8389fcc4c1253fe11fd310284dcf31ac6c02a749\"}}",
"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\": \"8389fcc4c1253fe11fd310284dcf31ac6c02a749\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@8389fcc4c1253fe11fd310284dcf31ac6c02a749\", \"title\": \"8389fcc4c1253fe11fd310284dcf31ac6c02a749\", \"url\": \"https://gnu.googlesource.com/gcc/+/8389fcc4c1253fe11fd310284dcf31ac6c02a749\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"build413-a9\", \"branch\": \"refs/heads/releases/gcc-9\", \"buildername\": \"gcc-arm64-linux\", \"git_revision\": \"8389fcc4c1253fe11fd310284dcf31ac6c02a749,a98c743fdf721a2333220209ca15e147badb55d1\", \"instance_id\": \"K3YRRj_vq1XxrHjmT1LYssYhzaGRokDD5uKcDeqxPjIC\", \"isolated\": \"4d935af40a4cd8fbdf8a369c57016a90f9bbde61\", \"mastername\": \"gcc\", \"package\": \"fuchsia/third_party/gcc/linux-arm64\", \"path_config\": \"generic\", \"recipe\": \"gcc_toolchain\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"8389fcc4c1253fe11fd310284dcf31ac6c02a749\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"git\", \"vpython\"], \"cores\": [\"256\"], \"cpu\": [\"arm\", \"arm-64\", \"arm64\", \"arm64-64\"], \"gce\": [\"0\"], \"gpu\": [\"1a03\", \"1a03:2000\"], \"id\": [\"build413-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\": [\"4825-3d129d6\"], \"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": "1582555463840543",
"status": "COMPLETED",
"status_changed_ts": "1582558978148337",
"tags": [
"builder:gcc-arm64-linux",
"buildset:commit/git/8389fcc4c1253fe11fd310284dcf31ac6c02a749",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/8389fcc4c1253fe11fd310284dcf31ac6c02a749",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9052994103208688464",
"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/8887564040345042160/+/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:4a9079826f4e1b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1582558978157309",
"url": "https://ci.chromium.org/b/8887564040345042160",
"utcnow_ts": "1582558978599895"
}
}
[15:42:58.612] Invocation finished in 58m39.212353496s with status SUCCEEDED