[20:06:12.607] New invocation is queued and will start shortly
[20:06:13.923] Starting the invocation (attempt 1)
[20:06:13.977] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:06:13.977] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:06:13.977] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9052067882223859024",
"parameters_json": "{\"builder_name\":\"gcc-x64-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\":\"07d52e63d999a0a10c7598c34c48365a357d3d5a\"},\"id\":\"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@07d52e63d999a0a10c7598c34c48365a357d3d5a\",\"title\":\"07d52e63d999a0a10c7598c34c48365a357d3d5a\",\"url\":\"https://gnu.googlesource.com/gcc/+/07d52e63d999a0a10c7598c34c48365a357d3d5a\"},{\"gitiles\":{\"ref\":\"refs/heads/releases/gcc-9\",\"repo\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"e50627ff8cd54c3983614b34727323b333b9374d\"},\"id\":\"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@e50627ff8cd54c3983614b34727323b333b9374d\",\"title\":\"e50627ff8cd54c3983614b34727323b333b9374d\",\"url\":\"https://gnu.googlesource.com/gcc/+/e50627ff8cd54c3983614b34727323b333b9374d\"}]},\"branch\":\"refs/heads/releases/gcc-9\",\"repository\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"e50627ff8cd54c3983614b34727323b333b9374d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-x64-linux",
"scheduler_invocation_id:9052067882223859024",
"scheduler_job_id:fuchsia/prod-gcc-x64-linux",
"user_agent:luci-scheduler",
"buildset:commit/git/e50627ff8cd54c3983614b34727323b333b9374d",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/e50627ff8cd54c3983614b34727323b333b9374d",
"gitiles_ref:refs/heads/releases/gcc-9"
]
}
[20:06:14.776] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1583438774133788",
"id": "8886637819933178416",
"parameters_json": "{\"builder_name\": \"gcc-x64-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\": \"07d52e63d999a0a10c7598c34c48365a357d3d5a\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@07d52e63d999a0a10c7598c34c48365a357d3d5a\", \"title\": \"07d52e63d999a0a10c7598c34c48365a357d3d5a\", \"url\": \"https://gnu.googlesource.com/gcc/+/07d52e63d999a0a10c7598c34c48365a357d3d5a\"}, {\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"e50627ff8cd54c3983614b34727323b333b9374d\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@e50627ff8cd54c3983614b34727323b333b9374d\", \"title\": \"e50627ff8cd54c3983614b34727323b333b9374d\", \"url\": \"https://gnu.googlesource.com/gcc/+/e50627ff8cd54c3983614b34727323b333b9374d\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"e50627ff8cd54c3983614b34727323b333b9374d\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583438774611374",
"tags": [
"builder:gcc-x64-linux",
"buildset:commit/git/e50627ff8cd54c3983614b34727323b333b9374d",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/e50627ff8cd54c3983614b34727323b333b9374d",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9052067882223859024",
"scheduler_job_id:fuchsia/prod-gcc-x64-linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/fuchsia/buildbucket/cr-buildbucket.appspot.com/8886637819933178416/+/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": "1583438774611485",
"url": "https://ci.chromium.org/b/8886637819933178416",
"utcnow_ts": "1583438774766111"
}
}
[20:06:14.776] Task URL: https://ci.chromium.org/b/8886637819933178416
[20:06:14.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:2:0) after 1m0s
[20:06:18.202] Received PubSub notification, asking Buildbucket for the build status
[20:06:18.550] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:14.864] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:2:0)
[20:07:14.864] Timer tick, asking Buildbucket for the build status
[20:07:14.965] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:14.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:4:0) after 1m0s
[20:08:15.098] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:4:0)
[20:08:15.098] Timer tick, asking Buildbucket for the build status
[20:08:15.221] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:15.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:5:0) after 1m0s
[20:09:15.606] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:5:0)
[20:09:15.606] Timer tick, asking Buildbucket for the build status
[20:09:15.776] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:15.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:6:0) after 1m0s
[20:10:15.931] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:6:0)
[20:10:15.931] Timer tick, asking Buildbucket for the build status
[20:10:16.080] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:16.080] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:7:0) after 1m0s
[20:11:16.230] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:7:0)
[20:11:16.230] Timer tick, asking Buildbucket for the build status
[20:11:17.347] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:17.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:8:0) after 1m0s
[20:12:17.488] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:8:0)
[20:12:17.488] Timer tick, asking Buildbucket for the build status
[20:12:17.543] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:17.543] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:9:0) after 1m0s
[20:13:17.606] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:9:0)
[20:13:17.606] Timer tick, asking Buildbucket for the build status
[20:13:17.692] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:17.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:10:0) after 1m0s
[20:14:17.945] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:10:0)
[20:14:17.945] Timer tick, asking Buildbucket for the build status
[20:14:18.293] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:18.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:11:0) after 1m0s
[20:15:18.466] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:11:0)
[20:15:18.466] Timer tick, asking Buildbucket for the build status
[20:15:18.702] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:18.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:12:0) after 1m0s
[20:16:18.865] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:12:0)
[20:16:18.865] Timer tick, asking Buildbucket for the build status
[20:16:18.937] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:18.937] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:13:0) after 1m0s
[20:17:18.995] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:13:0)
[20:17:18.995] Timer tick, asking Buildbucket for the build status
[20:17:19.076] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:19.076] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:14:0) after 1m0s
[20:18:19.256] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:14:0)
[20:18:19.256] Timer tick, asking Buildbucket for the build status
[20:18:19.338] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:19.338] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:15:0) after 1m0s
[20:19:19.430] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:15:0)
[20:19:19.430] Timer tick, asking Buildbucket for the build status
[20:19:19.550] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:19.550] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:16:0) after 1m0s
[20:20:19.570] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:16:0)
[20:20:19.570] Timer tick, asking Buildbucket for the build status
[20:20:19.866] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:19.866] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:17:0) after 1m0s
[20:21:19.912] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:17:0)
[20:21:19.912] Timer tick, asking Buildbucket for the build status
[20:21:20.054] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:20.054] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:18:0) after 1m0s
[20:22:20.302] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:18:0)
[20:22:20.302] Timer tick, asking Buildbucket for the build status
[20:22:20.484] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:20.484] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:19:0) after 1m0s
[20:23:20.501] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:19:0)
[20:23:20.501] Timer tick, asking Buildbucket for the build status
[20:23:20.794] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:20.794] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:20:0) after 1m0s
[20:24:20.905] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:20:0)
[20:24:20.905] Timer tick, asking Buildbucket for the build status
[20:24:21.086] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:21.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:21:0) after 1m0s
[20:25:21.148] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:21:0)
[20:25:21.148] Timer tick, asking Buildbucket for the build status
[20:25:21.303] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:21.303] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:22:0) after 1m0s
[20:26:21.371] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:22:0)
[20:26:21.371] Timer tick, asking Buildbucket for the build status
[20:26:21.438] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:21.440] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:23:0) after 1m0s
[20:27:21.485] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:23:0)
[20:27:21.485] Timer tick, asking Buildbucket for the build status
[20:27:21.560] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:21.560] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:24:0) after 1m0s
[20:28:21.675] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:24:0)
[20:28:21.675] Timer tick, asking Buildbucket for the build status
[20:28:21.923] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:21.923] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:25:0) after 1m0s
[20:29:22.103] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:25:0)
[20:29:22.104] Timer tick, asking Buildbucket for the build status
[20:29:22.342] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:22.342] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:26:0) after 1m0s
[20:30:22.492] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:26:0)
[20:30:22.492] Timer tick, asking Buildbucket for the build status
[20:30:22.617] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:22.617] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:27:0) after 1m0s
[20:31:22.920] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:27:0)
[20:31:22.920] Timer tick, asking Buildbucket for the build status
[20:31:23.269] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:23.269] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:28:0) after 1m0s
[20:32:23.452] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:28:0)
[20:32:23.452] Timer tick, asking Buildbucket for the build status
[20:32:24.004] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:24.004] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:29:0) after 1m0s
[20:33:24.067] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:29:0)
[20:33:24.067] Timer tick, asking Buildbucket for the build status
[20:33:24.508] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:24.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:30:0) after 1m0s
[20:34:24.585] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:30:0)
[20:34:24.585] Timer tick, asking Buildbucket for the build status
[20:34:24.804] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:24.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:31:0) after 1m0s
[20:35:24.794] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:31:0)
[20:35:24.794] Timer tick, asking Buildbucket for the build status
[20:35:24.928] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:24.928] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:32:0) after 1m0s
[20:36:25.487] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:32:0)
[20:36:25.487] Timer tick, asking Buildbucket for the build status
[20:36:26.118] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:26.118] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:33:0) after 1m0s
[20:37:26.186] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:33:0)
[20:37:26.186] Timer tick, asking Buildbucket for the build status
[20:37:26.311] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:26.311] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:34:0) after 1m0s
[20:38:26.396] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:34:0)
[20:38:26.396] Timer tick, asking Buildbucket for the build status
[20:38:26.988] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:26.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:35:0) after 1m0s
[20:39:27.121] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:35:0)
[20:39:27.121] Timer tick, asking Buildbucket for the build status
[20:39:27.225] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:27.225] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:36:0) after 1m0s
[20:40:27.295] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:36:0)
[20:40:27.295] Timer tick, asking Buildbucket for the build status
[20:40:27.761] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:27.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:37:0) after 1m0s
[20:41:27.781] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:37:0)
[20:41:27.781] Timer tick, asking Buildbucket for the build status
[20:41:27.929] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:27.929] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:38:0) after 1m0s
[20:42:27.979] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:38:0)
[20:42:27.979] Timer tick, asking Buildbucket for the build status
[20:42:28.073] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:28.073] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:39:0) after 1m0s
[20:43:28.113] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:39:0)
[20:43:28.113] Timer tick, asking Buildbucket for the build status
[20:43:28.377] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:28.377] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:40:0) after 1m0s
[20:44:28.553] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:40:0)
[20:44:28.553] Timer tick, asking Buildbucket for the build status
[20:44:28.798] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:28.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:41:0) after 1m0s
[20:45:28.924] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:41:0)
[20:45:28.924] Timer tick, asking Buildbucket for the build status
[20:45:29.161] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:29.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:42:0) after 1m0s
[20:46:29.145] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:42:0)
[20:46:29.145] Timer tick, asking Buildbucket for the build status
[20:46:29.414] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:29.414] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:43:0) after 1m0s
[20:47:29.500] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:43:0)
[20:47:29.500] Timer tick, asking Buildbucket for the build status
[20:47:29.616] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:29.616] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:44:0) after 1m0s
[20:48:29.635] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:44:0)
[20:48:29.635] Timer tick, asking Buildbucket for the build status
[20:48:29.745] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:29.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:45:0) after 1m0s
[20:49:29.840] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:45:0)
[20:49:29.840] Timer tick, asking Buildbucket for the build status
[20:49:30.260] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:30.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:46:0) after 1m0s
[20:50:30.366] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:46:0)
[20:50:30.366] Timer tick, asking Buildbucket for the build status
[20:50:30.627] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:30.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:47:0) after 1m0s
[20:51:30.688] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:47:0)
[20:51:30.688] Timer tick, asking Buildbucket for the build status
[20:51:30.794] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:30.794] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:48:0) after 1m0s
[20:52:30.828] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:48:0)
[20:52:30.828] Timer tick, asking Buildbucket for the build status
[20:52:30.925] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:30.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:49:0) after 1m0s
[20:53:31.040] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:49:0)
[20:53:31.040] Timer tick, asking Buildbucket for the build status
[20:53:31.318] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:31.318] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:50:0) after 1m0s
[20:54:31.378] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:50:0)
[20:54:31.378] Timer tick, asking Buildbucket for the build status
[20:54:31.803] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:31.803] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:51:0) after 1m0s
[20:55:31.839] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:51:0)
[20:55:31.839] Timer tick, asking Buildbucket for the build status
[20:55:32.094] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:32.094] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:52:0) after 1m0s
[20:56:32.187] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:52:0)
[20:56:32.187] Timer tick, asking Buildbucket for the build status
[20:56:32.430] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:32.430] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:53:0) after 1m0s
[20:57:32.491] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:53:0)
[20:57:32.491] Timer tick, asking Buildbucket for the build status
[20:57:32.757] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:32.757] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:54:0) after 1m0s
[20:58:33.125] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:54:0)
[20:58:33.125] Timer tick, asking Buildbucket for the build status
[20:58:33.339] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:33.339] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:55:0) after 1m0s
[20:59:33.453] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:55:0)
[20:59:33.453] Timer tick, asking Buildbucket for the build status
[20:59:33.542] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:33.542] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:56:0) after 1m0s
[21:00:33.644] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:56:0)
[21:00:33.644] Timer tick, asking Buildbucket for the build status
[21:00:33.795] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:33.795] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:57:0) after 1m0s
[21:01:33.841] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:57:0)
[21:01:33.841] Timer tick, asking Buildbucket for the build status
[21:01:33.997] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:33.997] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:58:0) after 1m0s
[21:02:34.027] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:58:0)
[21:02:34.027] Timer tick, asking Buildbucket for the build status
[21:02:34.195] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:34.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:59:0) after 1m0s
[21:03:34.249] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:59:0)
[21:03:34.249] Timer tick, asking Buildbucket for the build status
[21:03:34.556] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:34.556] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:60:0) after 1m0s
[21:04:34.583] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:60:0)
[21:04:34.583] Timer tick, asking Buildbucket for the build status
[21:04:34.852] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:34.852] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:61:0) after 1m0s
[21:05:34.973] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:61:0)
[21:05:34.973] Timer tick, asking Buildbucket for the build status
[21:05:35.119] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:35.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:62:0) after 1m0s
[21:06:35.161] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:62:0)
[21:06:35.161] Timer tick, asking Buildbucket for the build status
[21:06:35.282] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:35.282] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:63:0) after 1m0s
[21:07:35.340] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:63:0)
[21:07:35.340] Timer tick, asking Buildbucket for the build status
[21:07:35.469] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:35.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:64:0) after 1m0s
[21:08:35.656] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:64:0)
[21:08:35.656] Timer tick, asking Buildbucket for the build status
[21:08:35.878] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:35.878] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:65:0) after 1m0s
[21:09:36.006] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:65:0)
[21:09:36.006] Timer tick, asking Buildbucket for the build status
[21:09:36.156] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:36.156] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:66:0) after 1m0s
[21:10:36.160] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:66:0)
[21:10:36.160] Timer tick, asking Buildbucket for the build status
[21:10:36.587] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:36.587] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:67:0) after 1m0s
[21:11:36.666] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:67:0)
[21:11:36.666] Timer tick, asking Buildbucket for the build status
[21:11:37.131] Build 8886637819933178416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:37.131] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-linux:9052067882223859024:68:0) after 1m0s
[21:12:01.823] Received PubSub notification, asking Buildbucket for the build status
[21:12:02.071] Build 8886637819933178416: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:12:02.071] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1583442720656923",
"created_by": "project:fuchsia",
"created_ts": "1583438774133788",
"id": "8886637819933178416",
"parameters_json": "{\"builder_name\": \"gcc-x64-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\": \"07d52e63d999a0a10c7598c34c48365a357d3d5a\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@07d52e63d999a0a10c7598c34c48365a357d3d5a\", \"title\": \"07d52e63d999a0a10c7598c34c48365a357d3d5a\", \"url\": \"https://gnu.googlesource.com/gcc/+/07d52e63d999a0a10c7598c34c48365a357d3d5a\"}, {\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"e50627ff8cd54c3983614b34727323b333b9374d\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@e50627ff8cd54c3983614b34727323b333b9374d\", \"title\": \"e50627ff8cd54c3983614b34727323b333b9374d\", \"url\": \"https://gnu.googlesource.com/gcc/+/e50627ff8cd54c3983614b34727323b333b9374d\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"e50627ff8cd54c3983614b34727323b333b9374d\"}}",
"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\": \"07d52e63d999a0a10c7598c34c48365a357d3d5a\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@07d52e63d999a0a10c7598c34c48365a357d3d5a\", \"title\": \"07d52e63d999a0a10c7598c34c48365a357d3d5a\", \"url\": \"https://gnu.googlesource.com/gcc/+/07d52e63d999a0a10c7598c34c48365a357d3d5a\"}, {\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"e50627ff8cd54c3983614b34727323b333b9374d\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@e50627ff8cd54c3983614b34727323b333b9374d\", \"title\": \"e50627ff8cd54c3983614b34727323b333b9374d\", \"url\": \"https://gnu.googlesource.com/gcc/+/e50627ff8cd54c3983614b34727323b333b9374d\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"fuchsia-prod-32-us-central1-c-0-mimp\", \"branch\": \"refs/heads/releases/gcc-9\", \"buildername\": \"gcc-x64-linux\", \"git_revision\": \"e50627ff8cd54c3983614b34727323b333b9374d,a8e14f4cc2badfcf959f5e2cc57a941dc43f72d4\", \"instance_id\": \"LF4bcliwe-2r_IYlokurMvTi4zuWN6kEQZqvv7SSrOcC\", \"isolated\": \"fa2ee81560cc69617878bdd3a0396cfa9158e906\", \"mastername\": \"gcc\", \"package\": \"fuchsia/third_party/gcc/linux-amd64\", \"path_config\": \"generic\", \"recipe\": \"gcc_toolchain\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"e50627ff8cd54c3983614b34727323b333b9374d\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x64\", \"x86\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"fuchsia-infra\"], \"gpu\": [\"none\"], \"id\": [\"fuchsia-prod-32-us-central1-c-0-mimp\"], \"image\": [\"fuchsia-debian-9-drawfork-v20200212-956c4dc\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Debian\", \"Debian-9.11\", \"Linux\"], \"pool\": [\"luci.fuchsia.prod\"], \"python\": [\"2.7.13\"], \"role\": [\"builder\"], \"scale_group\": [\"fuchsia-prod-32\"], \"server_version\": [\"4851-268d16b\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1583438777074232",
"status": "COMPLETED",
"status_changed_ts": "1583442721077547",
"tags": [
"builder:gcc-x64-linux",
"buildset:commit/git/e50627ff8cd54c3983614b34727323b333b9374d",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/e50627ff8cd54c3983614b34727323b333b9374d",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9052067882223859024",
"scheduler_job_id:fuchsia/prod-gcc-x64-linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/fuchsia/buildbucket/cr-buildbucket.appspot.com/8886637819933178416/+/annotations",
"swarming_tag:luci_project:fuchsia",
"swarming_tag:os:Debian",
"swarming_tag:recipe_name:gcc_toolchain",
"swarming_tag:recipe_package:fuchsia/infra/recipe_bundles/fuchsia.googlesource.com/infra/recipes",
"swarming_task_id:4ac51fcb723b7c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1583442721097500",
"url": "https://ci.chromium.org/b/8886637819933178416",
"utcnow_ts": "1583442722055305"
}
}
[21:12:02.071] Invocation finished in 1h5m49.506099569s with status SUCCEEDED