[13:44:02.311] New invocation is queued and will start shortly
[13:44:03.433] Starting the invocation (attempt 1)
[13:44:03.503] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:44:03.504] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:44:03.504] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9052907299052746416",
"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\":\"eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\"},\"id\":\"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\",\"title\":\"eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\",\"url\":\"https://gnu.googlesource.com/gcc/+/eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\"}]},\"branch\":\"refs/heads/releases/gcc-9\",\"repository\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-arm64-linux",
"scheduler_invocation_id:9052907299052746416",
"scheduler_job_id:fuchsia/prod-gcc-arm64-linux",
"user_agent:luci-scheduler",
"buildset:commit/git/eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c",
"gitiles_ref:refs/heads/releases/gcc-9"
]
}
[13:44:04.178] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:fuchsia",
"created_ts": "1582638243657736",
"id": "8887477236977727520",
"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\": \"eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\", \"title\": \"eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\", \"url\": \"https://gnu.googlesource.com/gcc/+/eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582638244035951",
"tags": [
"builder:gcc-arm64-linux",
"buildset:commit/git/eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9052907299052746416",
"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/8887477236977727520/+/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": "1582638244036058",
"url": "https://ci.chromium.org/b/8887477236977727520",
"utcnow_ts": "1582638244169892"
}
}
[13:44:04.178] Task URL: https://ci.chromium.org/b/8887477236977727520
[13:44:04.178] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:2:0) after 1m0s
[13:44:11.364] Received PubSub notification, asking Buildbucket for the build status
[13:44:14.274] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:04.262] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:2:0)
[13:45:04.262] Timer tick, asking Buildbucket for the build status
[13:45:04.951] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:04.951] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:4:0) after 1m0s
[13:46:04.969] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:4:0)
[13:46:04.969] Timer tick, asking Buildbucket for the build status
[13:46:05.061] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:05.061] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:5:0) after 1m0s
[13:47:05.095] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:5:0)
[13:47:05.095] Timer tick, asking Buildbucket for the build status
[13:47:05.205] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:05.205] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:6:0) after 1m0s
[13:48:05.254] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:6:0)
[13:48:05.254] Timer tick, asking Buildbucket for the build status
[13:48:05.379] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:05.379] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:7:0) after 1m0s
[13:49:05.427] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:7:0)
[13:49:05.427] Timer tick, asking Buildbucket for the build status
[13:49:05.692] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:05.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:8:0) after 1m0s
[13:50:05.701] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:8:0)
[13:50:05.701] Timer tick, asking Buildbucket for the build status
[13:50:06.019] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:06.019] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:9:0) after 1m0s
[13:51:06.007] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:9:0)
[13:51:06.007] Timer tick, asking Buildbucket for the build status
[13:51:06.251] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:06.251] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:10:0) after 1m0s
[13:52:06.337] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:10:0)
[13:52:06.337] Timer tick, asking Buildbucket for the build status
[13:52:06.455] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:06.455] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:11:0) after 1m0s
[13:53:06.484] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:11:0)
[13:53:06.484] Timer tick, asking Buildbucket for the build status
[13:53:06.636] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:06.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:12:0) after 1m0s
[13:54:06.638] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:12:0)
[13:54:06.638] Timer tick, asking Buildbucket for the build status
[13:54:06.905] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:06.905] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:13:0) after 1m0s
[13:55:06.947] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:13:0)
[13:55:06.947] Timer tick, asking Buildbucket for the build status
[13:55:07.125] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:07.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:14:0) after 1m0s
[13:56:07.189] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:14:0)
[13:56:07.189] Timer tick, asking Buildbucket for the build status
[13:56:08.398] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:08.398] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:15:0) after 1m0s
[13:57:08.453] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:15:0)
[13:57:08.453] Timer tick, asking Buildbucket for the build status
[13:57:08.767] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:08.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:16:0) after 1m0s
[13:58:08.820] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:16:0)
[13:58:08.820] Timer tick, asking Buildbucket for the build status
[13:58:09.022] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:09.022] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:17:0) after 1m0s
[13:59:09.043] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:17:0)
[13:59:09.043] Timer tick, asking Buildbucket for the build status
[13:59:09.316] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:09.316] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:18:0) after 1m0s
[14:00:09.321] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:18:0)
[14:00:09.321] Timer tick, asking Buildbucket for the build status
[14:00:09.585] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:09.585] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:19:0) after 1m0s
[14:01:09.653] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:19:0)
[14:01:09.653] Timer tick, asking Buildbucket for the build status
[14:01:09.873] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:09.873] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:20:0) after 1m0s
[14:02:10.034] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:20:0)
[14:02:10.034] Timer tick, asking Buildbucket for the build status
[14:02:10.181] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:10.181] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:21:0) after 1m0s
[14:03:10.561] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:21:0)
[14:03:10.561] Timer tick, asking Buildbucket for the build status
[14:03:10.871] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:10.871] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:22:0) after 1m0s
[14:04:10.914] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:22:0)
[14:04:10.914] Timer tick, asking Buildbucket for the build status
[14:04:11.012] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:11.012] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:23:0) after 1m0s
[14:05:11.206] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:23:0)
[14:05:11.206] Timer tick, asking Buildbucket for the build status
[14:05:11.343] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:11.343] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:24:0) after 1m0s
[14:06:11.518] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:24:0)
[14:06:11.518] Timer tick, asking Buildbucket for the build status
[14:06:11.620] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:11.620] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:25:0) after 1m0s
[14:07:11.665] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:25:0)
[14:07:11.665] Timer tick, asking Buildbucket for the build status
[14:07:11.770] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:11.770] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:26:0) after 1m0s
[14:08:11.972] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:26:0)
[14:08:11.972] Timer tick, asking Buildbucket for the build status
[14:08:12.363] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:12.363] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:27:0) after 1m0s
[14:09:12.450] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:27:0)
[14:09:12.450] Timer tick, asking Buildbucket for the build status
[14:09:12.528] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:12.528] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:28:0) after 1m0s
[14:10:12.536] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:28:0)
[14:10:12.536] Timer tick, asking Buildbucket for the build status
[14:10:12.642] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:12.642] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:29:0) after 1m0s
[14:11:12.674] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:29:0)
[14:11:12.674] Timer tick, asking Buildbucket for the build status
[14:11:12.911] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:12.911] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:30:0) after 1m0s
[14:12:12.952] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:30:0)
[14:12:12.952] Timer tick, asking Buildbucket for the build status
[14:12:13.053] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:13.053] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:31:0) after 1m0s
[14:13:13.081] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:31:0)
[14:13:13.081] Timer tick, asking Buildbucket for the build status
[14:13:13.308] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:13.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:32:0) after 1m0s
[14:14:13.344] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:32:0)
[14:14:13.344] Timer tick, asking Buildbucket for the build status
[14:14:13.446] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:13.446] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:33:0) after 1m0s
[14:15:13.440] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:33:0)
[14:15:13.440] Timer tick, asking Buildbucket for the build status
[14:15:13.574] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:13.574] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:34:0) after 1m0s
[14:16:13.620] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:34:0)
[14:16:13.620] Timer tick, asking Buildbucket for the build status
[14:16:14.073] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:14.073] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:35:0) after 1m0s
[14:17:14.109] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:35:0)
[14:17:14.110] Timer tick, asking Buildbucket for the build status
[14:17:14.194] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:14.194] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:36:0) after 1m0s
[14:18:14.195] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:36:0)
[14:18:14.195] Timer tick, asking Buildbucket for the build status
[14:18:14.281] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:14.281] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:37:0) after 1m0s
[14:19:14.411] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:37:0)
[14:19:14.411] Timer tick, asking Buildbucket for the build status
[14:19:14.625] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:14.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:38:0) after 1m0s
[14:20:14.657] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:38:0)
[14:20:14.657] Timer tick, asking Buildbucket for the build status
[14:20:14.763] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:14.764] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:39:0) after 1m0s
[14:21:14.775] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:39:0)
[14:21:14.775] Timer tick, asking Buildbucket for the build status
[14:21:14.870] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:14.870] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:40:0) after 1m0s
[14:22:14.857] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:40:0)
[14:22:14.857] Timer tick, asking Buildbucket for the build status
[14:22:14.982] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:14.982] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:41:0) after 1m0s
[14:23:15.015] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:41:0)
[14:23:15.015] Timer tick, asking Buildbucket for the build status
[14:23:15.384] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:15.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:42:0) after 1m0s
[14:24:15.411] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:42:0)
[14:24:15.411] Timer tick, asking Buildbucket for the build status
[14:24:15.570] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:15.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:43:0) after 1m0s
[14:25:15.596] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:43:0)
[14:25:15.596] Timer tick, asking Buildbucket for the build status
[14:25:15.714] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:15.714] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:44:0) after 1m0s
[14:26:15.735] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:44:0)
[14:26:15.735] Timer tick, asking Buildbucket for the build status
[14:26:16.094] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:16.094] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:45:0) after 1m0s
[14:27:16.124] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:45:0)
[14:27:16.124] Timer tick, asking Buildbucket for the build status
[14:27:16.458] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:16.458] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:46:0) after 1m0s
[14:28:16.442] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:46:0)
[14:28:16.442] Timer tick, asking Buildbucket for the build status
[14:28:16.565] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:16.565] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:47:0) after 1m0s
[14:29:16.613] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:47:0)
[14:29:16.613] Timer tick, asking Buildbucket for the build status
[14:29:16.926] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:16.926] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:48:0) after 1m0s
[14:30:16.943] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:48:0)
[14:30:16.943] Timer tick, asking Buildbucket for the build status
[14:30:17.036] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:17.036] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:49:0) after 1m0s
[14:31:17.058] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:49:0)
[14:31:17.058] Timer tick, asking Buildbucket for the build status
[14:31:17.154] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:17.154] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:50:0) after 1m0s
[14:32:17.143] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:50:0)
[14:32:17.143] Timer tick, asking Buildbucket for the build status
[14:32:17.287] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:17.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:51:0) after 1m0s
[14:33:17.308] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:51:0)
[14:33:17.308] Timer tick, asking Buildbucket for the build status
[14:33:17.522] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:17.522] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:52:0) after 1m0s
[14:34:17.545] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:52:0)
[14:34:17.545] Timer tick, asking Buildbucket for the build status
[14:34:17.722] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:17.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:53:0) after 1m0s
[14:35:17.755] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:53:0)
[14:35:17.755] Timer tick, asking Buildbucket for the build status
[14:35:17.857] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:17.857] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:54:0) after 1m0s
[14:36:17.849] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:54:0)
[14:36:17.849] Timer tick, asking Buildbucket for the build status
[14:36:18.027] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:18.027] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:55:0) after 1m0s
[14:37:18.049] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:55:0)
[14:37:18.049] Timer tick, asking Buildbucket for the build status
[14:37:18.136] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:18.136] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:56:0) after 1m0s
[14:38:18.157] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:56:0)
[14:38:18.158] Timer tick, asking Buildbucket for the build status
[14:38:18.650] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:18.650] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:57:0) after 1m0s
[14:39:18.671] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:57:0)
[14:39:18.671] Timer tick, asking Buildbucket for the build status
[14:39:18.813] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:18.813] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:58:0) after 1m0s
[14:40:18.857] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:58:0)
[14:40:18.857] Timer tick, asking Buildbucket for the build status
[14:40:19.140] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:19.140] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:59:0) after 1m0s
[14:41:19.170] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:59:0)
[14:41:19.170] Timer tick, asking Buildbucket for the build status
[14:41:19.269] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:19.269] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:60:0) after 1m0s
[14:42:19.338] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:60:0)
[14:42:19.338] Timer tick, asking Buildbucket for the build status
[14:42:19.484] Build 8887477236977727520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:19.484] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052907299052746416:61:0) after 1m0s
[14:42:24.447] Received PubSub notification, asking Buildbucket for the build status
[14:42:24.514] Build 8887477236977727520: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:42:24.514] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1582641743826487",
"created_by": "project:fuchsia",
"created_ts": "1582638243657736",
"id": "8887477236977727520",
"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\": \"eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\", \"title\": \"eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\", \"url\": \"https://gnu.googlesource.com/gcc/+/eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\"}}",
"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\": \"eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\", \"title\": \"eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\", \"url\": \"https://gnu.googlesource.com/gcc/+/eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\"}]}, \"$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\": \"eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c,8cb5117ccfa578e6c531fcad4851be0f13b53f3b\", \"instance_id\": \"IHZGglPWFvIwnuIFojciGTTzEOq3RMUSlAb0P9zRah8C\", \"isolated\": \"a2a22d91d3627dbd913a1de0324eed83aae13f41\", \"mastername\": \"gcc\", \"package\": \"fuchsia/third_party/gcc/linux-arm64\", \"path_config\": \"generic\", \"recipe\": \"gcc_toolchain\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c\"}, \"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": "1582638250482049",
"status": "COMPLETED",
"status_changed_ts": "1582641744158618",
"tags": [
"builder:gcc-arm64-linux",
"buildset:commit/git/eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/eeb31391b7f223e6ca8cbd4452b99b55f4afdb1c",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9052907299052746416",
"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/8887477236977727520/+/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:4a9568a9b8a14310",
"user_agent:luci-scheduler"
],
"updated_ts": "1582641744171189",
"url": "https://ci.chromium.org/b/8887477236977727520",
"utcnow_ts": "1582641744504649"
}
}
[14:42:24.514] Invocation finished in 58m22.219827282s with status SUCCEEDED