[12:44:39.217] New invocation is queued and will start shortly
[12:44:40.479] Starting the invocation (attempt 1)
[12:44:40.574] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:44:40.574] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:44:40.574] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9053545213992587312",
"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\":\"52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\"},\"id\":\"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\",\"title\":\"52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\",\"url\":\"https://gnu.googlesource.com/gcc/+/52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\"},{\"gitiles\":{\"ref\":\"refs/heads/releases/gcc-9\",\"repo\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\"},\"id\":\"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\",\"title\":\"2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\",\"url\":\"https://gnu.googlesource.com/gcc/+/2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\"}]},\"branch\":\"refs/heads/releases/gcc-9\",\"repository\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-arm64-linux",
"scheduler_invocation_id:9053545213992587312",
"scheduler_job_id:fuchsia/prod-gcc-arm64-linux",
"user_agent:luci-scheduler",
"buildset:commit/git/2408b93a10c9c6cb210bc2a93d39ce6d56144ca3",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/2408b93a10c9c6cb210bc2a93d39ce6d56144ca3",
"gitiles_ref:refs/heads/releases/gcc-9"
]
}
[12:44:41.799] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1582029880797945",
"id": "8888115151672133920",
"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\": \"52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\", \"title\": \"52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\", \"url\": \"https://gnu.googlesource.com/gcc/+/52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\"}, {\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\", \"title\": \"2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\", \"url\": \"https://gnu.googlesource.com/gcc/+/2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582029881563214",
"tags": [
"builder:gcc-arm64-linux",
"buildset:commit/git/2408b93a10c9c6cb210bc2a93d39ce6d56144ca3",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/2408b93a10c9c6cb210bc2a93d39ce6d56144ca3",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9053545213992587312",
"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/8888115151672133920/+/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": "1582029881563516",
"url": "https://ci.chromium.org/b/8888115151672133920",
"utcnow_ts": "1582029881777061"
}
}
[12:44:41.799] Task URL: https://ci.chromium.org/b/8888115151672133920
[12:44:41.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:2:0) after 1m0s
[12:45:41.111] Received PubSub notification, asking Buildbucket for the build status
[12:45:41.206] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:42.105] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:2:0)
[12:45:42.105] Timer tick, asking Buildbucket for the build status
[12:45:42.249] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:42.249] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:4:0) after 1m0s
[12:46:42.350] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:4:0)
[12:46:42.350] Timer tick, asking Buildbucket for the build status
[12:46:42.579] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:42.579] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:5:0) after 1m0s
[12:47:42.789] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:5:0)
[12:47:42.789] Timer tick, asking Buildbucket for the build status
[12:47:42.934] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:42.934] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:6:0) after 1m0s
[12:48:42.970] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:6:0)
[12:48:42.970] Timer tick, asking Buildbucket for the build status
[12:48:43.265] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:43.265] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:7:0) after 1m0s
[12:49:43.306] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:7:0)
[12:49:43.306] Timer tick, asking Buildbucket for the build status
[12:49:43.401] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:43.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:8:0) after 1m0s
[12:50:43.438] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:8:0)
[12:50:43.438] Timer tick, asking Buildbucket for the build status
[12:50:43.589] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:43.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:9:0) after 1m0s
[12:51:43.665] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:9:0)
[12:51:43.665] Timer tick, asking Buildbucket for the build status
[12:51:43.987] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:43.987] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:10:0) after 1m0s
[12:52:44.014] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:10:0)
[12:52:44.014] Timer tick, asking Buildbucket for the build status
[12:52:44.405] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:44.405] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:11:0) after 1m0s
[12:53:44.511] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:11:0)
[12:53:44.511] Timer tick, asking Buildbucket for the build status
[12:53:44.631] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:44.631] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:12:0) after 1m0s
[12:54:44.653] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:12:0)
[12:54:44.653] Timer tick, asking Buildbucket for the build status
[12:54:44.869] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:44.869] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:13:0) after 1m0s
[12:55:44.938] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:13:0)
[12:55:44.938] Timer tick, asking Buildbucket for the build status
[12:55:45.039] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:45.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:14:0) after 1m0s
[12:56:45.162] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:14:0)
[12:56:45.162] Timer tick, asking Buildbucket for the build status
[12:56:45.312] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:45.312] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:15:0) after 1m0s
[12:57:45.350] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:15:0)
[12:57:45.350] Timer tick, asking Buildbucket for the build status
[12:57:45.594] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:45.594] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:16:0) after 1m0s
[12:58:45.627] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:16:0)
[12:58:45.627] Timer tick, asking Buildbucket for the build status
[12:58:46.174] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:46.174] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:17:0) after 1m0s
[12:59:46.257] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:17:0)
[12:59:46.257] Timer tick, asking Buildbucket for the build status
[12:59:46.453] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:46.453] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:18:0) after 1m0s
[13:00:46.528] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:18:0)
[13:00:46.528] Timer tick, asking Buildbucket for the build status
[13:00:46.709] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:46.709] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:19:0) after 1m0s
[13:01:46.829] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:19:0)
[13:01:46.829] Timer tick, asking Buildbucket for the build status
[13:01:46.952] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:46.952] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:20:0) after 1m0s
[13:02:47.013] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:20:0)
[13:02:47.013] Timer tick, asking Buildbucket for the build status
[13:02:47.181] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:47.181] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:21:0) after 1m0s
[13:03:47.305] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:21:0)
[13:03:47.305] Timer tick, asking Buildbucket for the build status
[13:03:47.778] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:47.778] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:22:0) after 1m0s
[13:04:47.840] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:22:0)
[13:04:47.840] Timer tick, asking Buildbucket for the build status
[13:04:47.987] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:47.987] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:23:0) after 1m0s
[13:05:48.082] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:23:0)
[13:05:48.082] Timer tick, asking Buildbucket for the build status
[13:05:48.252] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:48.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:24:0) after 1m0s
[13:06:48.355] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:24:0)
[13:06:48.355] Timer tick, asking Buildbucket for the build status
[13:06:48.462] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:48.462] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:25:0) after 1m0s
[13:07:48.583] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:25:0)
[13:07:48.583] Timer tick, asking Buildbucket for the build status
[13:07:48.638] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:48.638] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:26:0) after 1m0s
[13:08:48.666] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:26:0)
[13:08:48.666] Timer tick, asking Buildbucket for the build status
[13:08:48.837] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:48.837] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:27:0) after 1m0s
[13:09:48.918] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:27:0)
[13:09:48.918] Timer tick, asking Buildbucket for the build status
[13:09:49.127] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:49.127] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:28:0) after 1m0s
[13:10:49.241] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:28:0)
[13:10:49.241] Timer tick, asking Buildbucket for the build status
[13:10:49.449] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:49.449] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:29:0) after 1m0s
[13:11:49.858] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:29:0)
[13:11:49.858] Timer tick, asking Buildbucket for the build status
[13:11:49.938] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:49.938] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:30:0) after 1m0s
[13:12:50.196] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:30:0)
[13:12:50.196] Timer tick, asking Buildbucket for the build status
[13:12:50.360] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:50.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:31:0) after 1m0s
[13:13:50.424] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:31:0)
[13:13:50.424] Timer tick, asking Buildbucket for the build status
[13:13:50.614] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:50.614] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:32:0) after 1m0s
[13:14:50.793] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:32:0)
[13:14:50.793] Timer tick, asking Buildbucket for the build status
[13:14:50.963] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:50.963] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:33:0) after 1m0s
[13:15:51.153] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:33:0)
[13:15:51.153] Timer tick, asking Buildbucket for the build status
[13:15:51.563] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:51.563] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:34:0) after 1m0s
[13:16:51.741] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:34:0)
[13:16:51.741] Timer tick, asking Buildbucket for the build status
[13:16:51.880] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:51.880] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:35:0) after 1m0s
[13:17:51.974] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:35:0)
[13:17:51.974] Timer tick, asking Buildbucket for the build status
[13:17:52.137] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:52.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:36:0) after 1m0s
[13:18:52.174] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:36:0)
[13:18:52.174] Timer tick, asking Buildbucket for the build status
[13:18:52.348] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:52.348] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:37:0) after 1m0s
[13:19:52.481] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:37:0)
[13:19:52.481] Timer tick, asking Buildbucket for the build status
[13:19:52.627] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:52.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:38:0) after 1m0s
[13:20:53.298] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:38:0)
[13:20:53.298] Timer tick, asking Buildbucket for the build status
[13:20:53.433] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:53.433] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:39:0) after 1m0s
[13:21:53.526] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:39:0)
[13:21:53.526] Timer tick, asking Buildbucket for the build status
[13:21:53.628] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:53.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:40:0) after 1m0s
[13:22:53.989] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:40:0)
[13:22:53.989] Timer tick, asking Buildbucket for the build status
[13:22:54.135] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:54.135] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:41:0) after 1m0s
[13:23:54.481] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:41:0)
[13:23:54.481] Timer tick, asking Buildbucket for the build status
[13:23:54.596] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:54.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:42:0) after 1m0s
[13:24:54.726] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:42:0)
[13:24:54.726] Timer tick, asking Buildbucket for the build status
[13:24:55.010] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:55.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:43:0) after 1m0s
[13:25:55.222] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:43:0)
[13:25:55.222] Timer tick, asking Buildbucket for the build status
[13:25:55.336] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:55.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:44:0) after 1m0s
[13:26:55.393] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:44:0)
[13:26:55.393] Timer tick, asking Buildbucket for the build status
[13:26:55.508] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:55.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:45:0) after 1m0s
[13:27:55.632] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:45:0)
[13:27:55.632] Timer tick, asking Buildbucket for the build status
[13:27:56.013] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:56.013] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:46:0) after 1m0s
[13:28:56.209] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:46:0)
[13:28:56.209] Timer tick, asking Buildbucket for the build status
[13:28:56.330] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:56.330] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:47:0) after 1m0s
[13:29:56.398] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:47:0)
[13:29:56.398] Timer tick, asking Buildbucket for the build status
[13:29:56.767] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:56.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:48:0) after 1m0s
[13:30:57.108] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:48:0)
[13:30:57.108] Timer tick, asking Buildbucket for the build status
[13:30:58.281] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:58.281] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:49:0) after 1m0s
[13:31:58.562] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:49:0)
[13:31:58.562] Timer tick, asking Buildbucket for the build status
[13:31:58.842] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:58.842] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:50:0) after 1m0s
[13:32:59.055] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:50:0)
[13:32:59.055] Timer tick, asking Buildbucket for the build status
[13:32:59.279] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:59.279] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:51:0) after 1m0s
[13:33:59.408] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:51:0)
[13:33:59.408] Timer tick, asking Buildbucket for the build status
[13:33:59.901] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:59.901] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:52:0) after 1m0s
[13:35:00.102] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:52:0)
[13:35:00.102] Timer tick, asking Buildbucket for the build status
[13:35:00.251] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:00.251] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:53:0) after 1m0s
[13:36:00.338] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:53:0)
[13:36:00.338] Timer tick, asking Buildbucket for the build status
[13:36:00.646] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:00.646] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:54:0) after 1m0s
[13:37:00.750] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:54:0)
[13:37:00.750] Timer tick, asking Buildbucket for the build status
[13:37:01.168] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:01.168] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:55:0) after 1m0s
[13:38:01.187] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:55:0)
[13:38:01.187] Timer tick, asking Buildbucket for the build status
[13:38:01.500] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:01.500] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:56:0) after 1m0s
[13:39:01.714] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:56:0)
[13:39:01.714] Timer tick, asking Buildbucket for the build status
[13:39:01.804] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:01.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:57:0) after 1m0s
[13:40:01.886] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:57:0)
[13:40:01.886] Timer tick, asking Buildbucket for the build status
[13:40:02.010] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:02.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:58:0) after 1m0s
[13:41:02.047] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:58:0)
[13:41:02.047] Timer tick, asking Buildbucket for the build status
[13:41:02.162] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:02.162] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:59:0) after 1m0s
[13:42:02.188] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:59:0)
[13:42:02.188] Timer tick, asking Buildbucket for the build status
[13:42:02.463] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:02.463] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:60:0) after 1m0s
[13:43:02.485] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:60:0)
[13:43:02.485] Timer tick, asking Buildbucket for the build status
[13:43:02.616] Build 8888115151672133920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:02.616] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053545213992587312:61:0) after 1m0s
[13:43:46.852] Received PubSub notification, asking Buildbucket for the build status
[13:43:46.916] Build 8888115151672133920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:43:46.916] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1582033425777293",
"created_by": "project:fuchsia",
"created_ts": "1582029880797945",
"id": "8888115151672133920",
"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\": \"52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\", \"title\": \"52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\", \"url\": \"https://gnu.googlesource.com/gcc/+/52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\"}, {\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\", \"title\": \"2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\", \"url\": \"https://gnu.googlesource.com/gcc/+/2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\"}}",
"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\": \"52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\", \"title\": \"52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\", \"url\": \"https://gnu.googlesource.com/gcc/+/52db14c1f700e14e5b1b6c7fc702c0a08cc3781c\"}, {\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\", \"title\": \"2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\", \"url\": \"https://gnu.googlesource.com/gcc/+/2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\"}]}, \"$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\": \"2408b93a10c9c6cb210bc2a93d39ce6d56144ca3,685313de6b2ae6e4b2ad32935cbb18d65ebd42ce\", \"instance_id\": \"vy8qvtJp9lwAN89-eqEsQNuLjpC8TtEn2AyFXHL2mfAC\", \"isolated\": \"db296566d1540cfca0bbd1e0acc2db4b2100eabb\", \"mastername\": \"gcc\", \"package\": \"fuchsia/third_party/gcc/linux-arm64\", \"path_config\": \"generic\", \"recipe\": \"gcc_toolchain\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"2408b93a10c9c6cb210bc2a93d39ce6d56144ca3\"}, \"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\": [\"4821-6a867f1\"], \"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": "1582029940442549",
"status": "COMPLETED",
"status_changed_ts": "1582033426486507",
"tags": [
"builder:gcc-arm64-linux",
"buildset:commit/git/2408b93a10c9c6cb210bc2a93d39ce6d56144ca3",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/2408b93a10c9c6cb210bc2a93d39ce6d56144ca3",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9053545213992587312",
"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/8888115151672133920/+/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:4a7125cb19027410",
"user_agent:luci-scheduler"
],
"updated_ts": "1582033426545104",
"url": "https://ci.chromium.org/b/8888115151672133920",
"utcnow_ts": "1582033426908087"
}
}
[13:43:46.916] Invocation finished in 59m7.716177017s with status SUCCEEDED