[12:43:22.531] New invocation is queued and will start shortly
[12:43:23.698] Starting the invocation (attempt 1)
[12:43:23.733] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:43:23.733] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:43:23.733] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9052911115637814944",
"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\":\"a6b74eaedf6199a5431504a77ecacb0f9efa53f9\"},\"id\":\"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@a6b74eaedf6199a5431504a77ecacb0f9efa53f9\",\"title\":\"a6b74eaedf6199a5431504a77ecacb0f9efa53f9\",\"url\":\"https://gnu.googlesource.com/gcc/+/a6b74eaedf6199a5431504a77ecacb0f9efa53f9\"}]},\"branch\":\"refs/heads/releases/gcc-9\",\"repository\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"a6b74eaedf6199a5431504a77ecacb0f9efa53f9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-arm64-linux",
"scheduler_invocation_id:9052911115637814944",
"scheduler_job_id:fuchsia/prod-gcc-arm64-linux",
"user_agent:luci-scheduler",
"buildset:commit/git/a6b74eaedf6199a5431504a77ecacb0f9efa53f9",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/a6b74eaedf6199a5431504a77ecacb0f9efa53f9",
"gitiles_ref:refs/heads/releases/gcc-9"
]
}
[12:43:26.186] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1582634603844411",
"id": "8887481053598206768",
"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\": \"a6b74eaedf6199a5431504a77ecacb0f9efa53f9\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@a6b74eaedf6199a5431504a77ecacb0f9efa53f9\", \"title\": \"a6b74eaedf6199a5431504a77ecacb0f9efa53f9\", \"url\": \"https://gnu.googlesource.com/gcc/+/a6b74eaedf6199a5431504a77ecacb0f9efa53f9\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"a6b74eaedf6199a5431504a77ecacb0f9efa53f9\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582634604868270",
"tags": [
"builder:gcc-arm64-linux",
"buildset:commit/git/a6b74eaedf6199a5431504a77ecacb0f9efa53f9",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/a6b74eaedf6199a5431504a77ecacb0f9efa53f9",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9052911115637814944",
"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/8887481053598206768/+/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": "1582634604868432",
"url": "https://ci.chromium.org/b/8887481053598206768",
"utcnow_ts": "1582634606108210"
}
}
[12:43:26.186] Task URL: https://ci.chromium.org/b/8887481053598206768
[12:43:26.186] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:2:0) after 1m0s
[12:43:29.386] Received PubSub notification, asking Buildbucket for the build status
[12:43:29.470] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:26.251] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:2:0)
[12:44:26.252] Timer tick, asking Buildbucket for the build status
[12:44:26.577] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:26.577] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:4:0) after 1m0s
[12:45:26.591] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:4:0)
[12:45:26.591] Timer tick, asking Buildbucket for the build status
[12:45:26.998] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:26.998] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:5:0) after 1m0s
[12:46:27.046] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:5:0)
[12:46:27.046] Timer tick, asking Buildbucket for the build status
[12:46:27.409] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:27.409] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:6:0) after 1m0s
[12:47:27.415] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:6:0)
[12:47:27.415] Timer tick, asking Buildbucket for the build status
[12:47:27.673] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:27.673] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:7:0) after 1m0s
[12:48:27.770] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:7:0)
[12:48:27.770] Timer tick, asking Buildbucket for the build status
[12:48:28.032] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:28.032] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:8:0) after 1m0s
[12:49:28.128] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:8:0)
[12:49:28.128] Timer tick, asking Buildbucket for the build status
[12:49:28.509] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:28.509] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:9:0) after 1m0s
[12:50:28.599] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:9:0)
[12:50:28.599] Timer tick, asking Buildbucket for the build status
[12:50:28.717] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:28.717] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:10:0) after 1m0s
[12:51:28.745] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:10:0)
[12:51:28.745] Timer tick, asking Buildbucket for the build status
[12:51:29.183] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:29.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:11:0) after 1m0s
[12:52:29.204] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:11:0)
[12:52:29.204] Timer tick, asking Buildbucket for the build status
[12:52:29.330] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:29.330] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:12:0) after 1m0s
[12:53:29.358] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:12:0)
[12:53:29.358] Timer tick, asking Buildbucket for the build status
[12:53:29.459] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:29.459] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:13:0) after 1m0s
[12:54:29.470] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:13:0)
[12:54:29.470] Timer tick, asking Buildbucket for the build status
[12:54:29.805] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:29.805] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:14:0) after 1m0s
[12:55:29.891] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:14:0)
[12:55:29.891] Timer tick, asking Buildbucket for the build status
[12:55:30.102] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:30.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:15:0) after 1m0s
[12:56:30.132] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:15:0)
[12:56:30.132] Timer tick, asking Buildbucket for the build status
[12:56:30.375] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:30.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:16:0) after 1m0s
[12:57:30.414] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:16:0)
[12:57:30.414] Timer tick, asking Buildbucket for the build status
[12:57:30.506] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:30.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:17:0) after 1m0s
[12:58:30.558] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:17:0)
[12:58:30.558] Timer tick, asking Buildbucket for the build status
[12:58:30.781] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:30.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:18:0) after 1m0s
[12:59:30.788] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:18:0)
[12:59:30.788] Timer tick, asking Buildbucket for the build status
[12:59:30.923] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:30.923] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:19:0) after 1m0s
[13:00:30.951] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:19:0)
[13:00:30.952] Timer tick, asking Buildbucket for the build status
[13:00:32.093] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:32.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:20:0) after 1m0s
[13:01:32.153] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:20:0)
[13:01:32.153] Timer tick, asking Buildbucket for the build status
[13:01:32.452] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:32.452] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:21:0) after 1m0s
[13:02:32.480] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:21:0)
[13:02:32.481] Timer tick, asking Buildbucket for the build status
[13:02:32.751] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:32.751] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:22:0) after 1m0s
[13:03:32.772] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:22:0)
[13:03:32.772] Timer tick, asking Buildbucket for the build status
[13:03:33.022] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:33.022] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:23:0) after 1m0s
[13:04:33.041] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:23:0)
[13:04:33.041] Timer tick, asking Buildbucket for the build status
[13:04:33.478] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:33.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:24:0) after 1m0s
[13:05:33.513] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:24:0)
[13:05:33.513] Timer tick, asking Buildbucket for the build status
[13:05:33.750] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:33.750] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:25:0) after 1m0s
[13:06:33.781] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:25:0)
[13:06:33.781] Timer tick, asking Buildbucket for the build status
[13:06:34.742] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:34.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:26:0) after 1m0s
[13:07:34.800] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:26:0)
[13:07:34.800] Timer tick, asking Buildbucket for the build status
[13:07:34.975] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:34.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:27:0) after 1m0s
[13:08:34.999] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:27:0)
[13:08:34.999] Timer tick, asking Buildbucket for the build status
[13:08:35.091] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:35.091] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:28:0) after 1m0s
[13:09:35.143] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:28:0)
[13:09:35.143] Timer tick, asking Buildbucket for the build status
[13:09:35.285] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:35.285] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:29:0) after 1m0s
[13:10:35.363] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:29:0)
[13:10:35.363] Timer tick, asking Buildbucket for the build status
[13:10:35.746] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:35.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:30:0) after 1m0s
[13:11:35.798] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:30:0)
[13:11:35.798] Timer tick, asking Buildbucket for the build status
[13:11:36.108] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:36.108] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:31:0) after 1m0s
[13:12:36.192] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:31:0)
[13:12:36.192] Timer tick, asking Buildbucket for the build status
[13:12:36.346] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:36.346] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:32:0) after 1m0s
[13:13:36.492] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:32:0)
[13:13:36.492] Timer tick, asking Buildbucket for the build status
[13:13:37.012] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:37.012] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:33:0) after 1m0s
[13:14:37.102] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:33:0)
[13:14:37.102] Timer tick, asking Buildbucket for the build status
[13:14:37.309] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:37.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:34:0) after 1m0s
[13:15:37.394] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:34:0)
[13:15:37.394] Timer tick, asking Buildbucket for the build status
[13:15:37.512] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:37.512] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:35:0) after 1m0s
[13:16:37.527] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:35:0)
[13:16:37.527] Timer tick, asking Buildbucket for the build status
[13:16:37.638] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:37.638] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:36:0) after 1m0s
[13:17:37.726] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:36:0)
[13:17:37.726] Timer tick, asking Buildbucket for the build status
[13:17:38.092] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:38.092] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:37:0) after 1m0s
[13:18:38.139] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:37:0)
[13:18:38.139] Timer tick, asking Buildbucket for the build status
[13:18:38.319] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:38.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:38:0) after 1m0s
[13:19:38.365] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:38:0)
[13:19:38.365] Timer tick, asking Buildbucket for the build status
[13:19:38.470] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:38.470] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:39:0) after 1m0s
[13:20:38.660] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:39:0)
[13:20:38.660] Timer tick, asking Buildbucket for the build status
[13:20:38.853] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:38.853] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:40:0) after 1m0s
[13:21:38.872] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:40:0)
[13:21:38.872] Timer tick, asking Buildbucket for the build status
[13:21:38.981] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:38.981] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:41:0) after 1m0s
[13:22:39.033] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:41:0)
[13:22:39.034] Timer tick, asking Buildbucket for the build status
[13:22:39.535] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:39.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:42:0) after 1m0s
[13:23:39.605] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:42:0)
[13:23:39.605] Timer tick, asking Buildbucket for the build status
[13:23:39.701] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:39.701] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:43:0) after 1m0s
[13:24:39.721] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:43:0)
[13:24:39.721] Timer tick, asking Buildbucket for the build status
[13:24:40.064] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:40.064] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:44:0) after 1m0s
[13:25:40.115] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:44:0)
[13:25:40.115] Timer tick, asking Buildbucket for the build status
[13:25:40.283] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:40.283] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:45:0) after 1m0s
[13:26:40.417] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:45:0)
[13:26:40.417] Timer tick, asking Buildbucket for the build status
[13:26:40.548] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:40.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:46:0) after 1m0s
[13:27:40.724] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:46:0)
[13:27:40.724] Timer tick, asking Buildbucket for the build status
[13:27:40.910] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:40.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:47:0) after 1m0s
[13:28:41.008] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:47:0)
[13:28:41.008] Timer tick, asking Buildbucket for the build status
[13:28:41.131] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:41.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:48:0) after 1m0s
[13:29:41.165] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:48:0)
[13:29:41.165] Timer tick, asking Buildbucket for the build status
[13:29:41.265] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:41.265] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:49:0) after 1m0s
[13:30:41.332] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:49:0)
[13:30:41.332] Timer tick, asking Buildbucket for the build status
[13:30:41.438] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:41.438] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:50:0) after 1m0s
[13:31:41.474] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:50:0)
[13:31:41.474] Timer tick, asking Buildbucket for the build status
[13:31:41.598] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:41.598] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:51:0) after 1m0s
[13:32:41.644] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:51:0)
[13:32:41.644] Timer tick, asking Buildbucket for the build status
[13:32:41.767] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:41.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:52:0) after 1m0s
[13:33:41.845] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:52:0)
[13:33:41.845] Timer tick, asking Buildbucket for the build status
[13:33:41.940] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:41.940] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:53:0) after 1m0s
[13:34:41.989] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:53:0)
[13:34:41.989] Timer tick, asking Buildbucket for the build status
[13:34:42.258] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:42.258] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:54:0) after 1m0s
[13:35:42.287] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:54:0)
[13:35:42.287] Timer tick, asking Buildbucket for the build status
[13:35:42.563] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:42.563] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:55:0) after 1m0s
[13:36:42.675] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:55:0)
[13:36:42.675] Timer tick, asking Buildbucket for the build status
[13:36:42.858] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:42.858] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:56:0) after 1m0s
[13:37:43.013] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:56:0)
[13:37:43.013] Timer tick, asking Buildbucket for the build status
[13:37:43.140] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:43.141] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:57:0) after 1m0s
[13:38:43.298] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:57:0)
[13:38:43.298] Timer tick, asking Buildbucket for the build status
[13:38:43.431] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:43.431] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:58:0) after 1m0s
[13:39:43.481] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:58:0)
[13:39:43.481] Timer tick, asking Buildbucket for the build status
[13:39:43.658] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:43.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:59:0) after 1m0s
[13:40:43.724] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:59:0)
[13:40:43.724] Timer tick, asking Buildbucket for the build status
[13:40:43.843] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:43.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:60:0) after 1m0s
[13:41:43.862] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:60:0)
[13:41:43.862] Timer tick, asking Buildbucket for the build status
[13:41:44.245] Build 8887481053598206768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:44.245] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9052911115637814944:61:0) after 1m0s
[13:42:13.658] Received PubSub notification, asking Buildbucket for the build status
[13:42:13.943] Build 8887481053598206768: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:42:13.943] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1582638132753788",
"created_by": "project:fuchsia",
"created_ts": "1582634603844411",
"id": "8887481053598206768",
"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\": \"a6b74eaedf6199a5431504a77ecacb0f9efa53f9\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@a6b74eaedf6199a5431504a77ecacb0f9efa53f9\", \"title\": \"a6b74eaedf6199a5431504a77ecacb0f9efa53f9\", \"url\": \"https://gnu.googlesource.com/gcc/+/a6b74eaedf6199a5431504a77ecacb0f9efa53f9\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"a6b74eaedf6199a5431504a77ecacb0f9efa53f9\"}}",
"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\": \"a6b74eaedf6199a5431504a77ecacb0f9efa53f9\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@a6b74eaedf6199a5431504a77ecacb0f9efa53f9\", \"title\": \"a6b74eaedf6199a5431504a77ecacb0f9efa53f9\", \"url\": \"https://gnu.googlesource.com/gcc/+/a6b74eaedf6199a5431504a77ecacb0f9efa53f9\"}]}, \"$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\": \"a6b74eaedf6199a5431504a77ecacb0f9efa53f9,8cb5117ccfa578e6c531fcad4851be0f13b53f3b\", \"instance_id\": \"4fQwXgBBXSs7eO-cWScKVmekQdHE3DlJTgsE_tLpc0gC\", \"isolated\": \"4bcb61b14169be767ed7d006967418305912bf44\", \"mastername\": \"gcc\", \"package\": \"fuchsia/third_party/gcc/linux-arm64\", \"path_config\": \"generic\", \"recipe\": \"gcc_toolchain\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"a6b74eaedf6199a5431504a77ecacb0f9efa53f9\"}, \"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": "1582634608479372",
"status": "COMPLETED",
"status_changed_ts": "1582638133063534",
"tags": [
"builder:gcc-arm64-linux",
"buildset:commit/git/a6b74eaedf6199a5431504a77ecacb0f9efa53f9",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/a6b74eaedf6199a5431504a77ecacb0f9efa53f9",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9052911115637814944",
"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/8887481053598206768/+/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:4a953126d0086910",
"user_agent:luci-scheduler"
],
"updated_ts": "1582638133072886",
"url": "https://ci.chromium.org/b/8887481053598206768",
"utcnow_ts": "1582638133930244"
}
}
[13:42:13.943] Invocation finished in 58m51.427828828s with status SUCCEEDED