[06:33:46.272] New invocation is queued and will start shortly
[06:33:47.507] Starting the invocation (attempt 1)
[06:33:47.553] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:33:47.553] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:33:47.553] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9029016770019043632",
"parameters_json": "{\"builder_name\":\"gcc-prod-trigger\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"9dd02fc063284f59994c095ce525e1b8934b0dc1\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@9dd02fc063284f59994c095ce525e1b8934b0dc1\",\"title\":\"9dd02fc063284f59994c095ce525e1b8934b0dc1\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/9dd02fc063284f59994c095ce525e1b8934b0dc1\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"9dd02fc063284f59994c095ce525e1b8934b0dc1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-prod-trigger",
"scheduler_invocation_id:9029016770019043632",
"scheduler_job_id:fuchsia/gcc-prod-trigger-3e002780",
"user_agent:luci-scheduler",
"buildset:commit/git/9dd02fc063284f59994c095ce525e1b8934b0dc1",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/9dd02fc063284f59994c095ce525e1b8934b0dc1",
"gitiles_ref:refs/heads/master"
]
}
[06:33:48.900] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1605422027742216",
"id": "8863586707796472944",
"parameters_json": "{\"builder_name\": \"gcc-prod-trigger\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"9dd02fc063284f59994c095ce525e1b8934b0dc1\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@9dd02fc063284f59994c095ce525e1b8934b0dc1\", \"title\": \"9dd02fc063284f59994c095ce525e1b8934b0dc1\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/9dd02fc063284f59994c095ce525e1b8934b0dc1\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"9dd02fc063284f59994c095ce525e1b8934b0dc1\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605422028616770",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/9dd02fc063284f59994c095ce525e1b8934b0dc1",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/9dd02fc063284f59994c095ce525e1b8934b0dc1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029016770019043632",
"scheduler_job_id:fuchsia/gcc-prod-trigger-3e002780",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/fuchsia/buildbucket/cr-buildbucket.appspot.com/8863586707796472944/+/annotations",
"swarming_tag:luci_project:fuchsia",
"swarming_tag:recipe_name:toolchain_trigger",
"swarming_tag:recipe_package:fuchsia/infra/recipe_bundles/fuchsia.googlesource.com/infra/recipes",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1605422028616957",
"url": "https://ci.chromium.org/b/8863586707796472944",
"utcnow_ts": "1605422028844015"
}
}
[06:33:48.900] Task URL: https://ci.chromium.org/b/8863586707796472944
[06:33:48.900] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:2:0) after 1m0s
[06:33:59.111] Received PubSub notification, asking Buildbucket for the build status
[06:33:59.205] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:49.201] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:2:0)
[06:34:49.201] Timer tick, asking Buildbucket for the build status
[06:34:49.277] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:49.277] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:4:0) after 1m0s
[06:35:49.447] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:4:0)
[06:35:49.448] Timer tick, asking Buildbucket for the build status
[06:35:49.603] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:49.603] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:5:0) after 1m0s
[06:36:49.667] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:5:0)
[06:36:49.667] Timer tick, asking Buildbucket for the build status
[06:36:49.745] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:49.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:6:0) after 1m0s
[06:37:49.917] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:6:0)
[06:37:49.917] Timer tick, asking Buildbucket for the build status
[06:37:50.005] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:50.005] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:7:0) after 1m0s
[06:38:50.150] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:7:0)
[06:38:50.151] Timer tick, asking Buildbucket for the build status
[06:38:50.228] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:50.229] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:8:0) after 1m0s
[06:39:50.232] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:8:0)
[06:39:50.232] Timer tick, asking Buildbucket for the build status
[06:39:50.318] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:50.318] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:9:0) after 1m0s
[06:40:50.459] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:9:0)
[06:40:50.459] Timer tick, asking Buildbucket for the build status
[06:40:50.534] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:50.534] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:10:0) after 1m0s
[06:41:50.732] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:10:0)
[06:41:50.732] Timer tick, asking Buildbucket for the build status
[06:41:50.816] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:50.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:11:0) after 1m0s
[06:42:51.043] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:11:0)
[06:42:51.043] Timer tick, asking Buildbucket for the build status
[06:42:51.277] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:51.278] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:12:0) after 1m0s
[06:43:51.378] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:12:0)
[06:43:51.378] Timer tick, asking Buildbucket for the build status
[06:43:51.458] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:51.458] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:13:0) after 1m0s
[06:44:51.527] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:13:0)
[06:44:51.527] Timer tick, asking Buildbucket for the build status
[06:44:53.431] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:53.431] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:14:0) after 1m0s
[06:45:53.431] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:14:0)
[06:45:53.431] Timer tick, asking Buildbucket for the build status
[06:45:53.505] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:53.505] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:15:0) after 1m0s
[06:46:53.626] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:15:0)
[06:46:53.626] Timer tick, asking Buildbucket for the build status
[06:46:53.807] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:53.807] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:16:0) after 1m0s
[06:47:53.850] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:16:0)
[06:47:53.850] Timer tick, asking Buildbucket for the build status
[06:47:53.922] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:53.922] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:17:0) after 1m0s
[06:48:54.051] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:17:0)
[06:48:54.051] Timer tick, asking Buildbucket for the build status
[06:48:54.489] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:54.489] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:18:0) after 1m0s
[06:49:54.581] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:18:0)
[06:49:54.581] Timer tick, asking Buildbucket for the build status
[06:49:54.684] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:54.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:19:0) after 1m0s
[06:50:54.729] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:19:0)
[06:50:54.729] Timer tick, asking Buildbucket for the build status
[06:50:55.133] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:55.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:20:0) after 1m0s
[06:51:55.121] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:20:0)
[06:51:55.121] Timer tick, asking Buildbucket for the build status
[06:51:55.198] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:55.198] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:21:0) after 1m0s
[06:52:55.228] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:21:0)
[06:52:55.229] Timer tick, asking Buildbucket for the build status
[06:52:55.306] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:55.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:22:0) after 1m0s
[06:53:55.326] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:22:0)
[06:53:55.326] Timer tick, asking Buildbucket for the build status
[06:53:55.431] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:55.431] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:23:0) after 1m0s
[06:54:55.461] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:23:0)
[06:54:55.461] Timer tick, asking Buildbucket for the build status
[06:54:55.706] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:55.706] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:24:0) after 1m0s
[06:55:55.723] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:24:0)
[06:55:55.723] Timer tick, asking Buildbucket for the build status
[06:55:55.829] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:55.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:25:0) after 1m0s
[06:56:55.907] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:25:0)
[06:56:55.907] Timer tick, asking Buildbucket for the build status
[06:56:56.087] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:56.087] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:26:0) after 1m0s
[06:57:56.126] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:26:0)
[06:57:56.126] Timer tick, asking Buildbucket for the build status
[06:57:56.476] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:56.476] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:27:0) after 1m0s
[06:58:56.495] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:27:0)
[06:58:56.495] Timer tick, asking Buildbucket for the build status
[06:58:56.670] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:56.670] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:28:0) after 1m0s
[06:59:56.704] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:28:0)
[06:59:56.704] Timer tick, asking Buildbucket for the build status
[06:59:56.818] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:56.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:29:0) after 1m0s
[07:00:56.874] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:29:0)
[07:00:56.874] Timer tick, asking Buildbucket for the build status
[07:00:57.042] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:57.042] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:30:0) after 1m0s
[07:01:57.065] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:30:0)
[07:01:57.065] Timer tick, asking Buildbucket for the build status
[07:01:57.149] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:57.149] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:31:0) after 1m0s
[07:02:57.174] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:31:0)
[07:02:57.174] Timer tick, asking Buildbucket for the build status
[07:02:57.262] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:57.262] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:32:0) after 1m0s
[07:03:57.287] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:32:0)
[07:03:57.287] Timer tick, asking Buildbucket for the build status
[07:03:57.792] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:57.792] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:33:0) after 1m0s
[07:04:57.799] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:33:0)
[07:04:57.799] Timer tick, asking Buildbucket for the build status
[07:04:57.869] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:57.870] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:34:0) after 1m0s
[07:05:57.911] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:34:0)
[07:05:57.911] Timer tick, asking Buildbucket for the build status
[07:05:58.116] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:58.116] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:35:0) after 1m0s
[07:06:58.149] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:35:0)
[07:06:58.149] Timer tick, asking Buildbucket for the build status
[07:06:58.285] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:58.285] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:36:0) after 1m0s
[07:07:58.384] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:36:0)
[07:07:58.384] Timer tick, asking Buildbucket for the build status
[07:07:58.457] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:58.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:37:0) after 1m0s
[07:08:58.468] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:37:0)
[07:08:58.468] Timer tick, asking Buildbucket for the build status
[07:08:58.578] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:58.578] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:38:0) after 1m0s
[07:09:58.640] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:38:0)
[07:09:58.640] Timer tick, asking Buildbucket for the build status
[07:09:58.784] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:58.784] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:39:0) after 1m0s
[07:10:58.909] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:39:0)
[07:10:58.909] Timer tick, asking Buildbucket for the build status
[07:10:59.287] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:59.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:40:0) after 1m0s
[07:11:59.312] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:40:0)
[07:11:59.312] Timer tick, asking Buildbucket for the build status
[07:11:59.391] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:59.391] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:41:0) after 1m0s
[07:12:59.441] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:41:0)
[07:12:59.441] Timer tick, asking Buildbucket for the build status
[07:12:59.536] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:59.536] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:42:0) after 1m0s
[07:13:59.594] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:42:0)
[07:13:59.594] Timer tick, asking Buildbucket for the build status
[07:13:59.707] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:59.707] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:43:0) after 1m0s
[07:14:59.728] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:43:0)
[07:14:59.728] Timer tick, asking Buildbucket for the build status
[07:14:59.804] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:59.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:44:0) after 1m0s
[07:15:59.814] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:44:0)
[07:15:59.814] Timer tick, asking Buildbucket for the build status
[07:15:59.892] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:59.892] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:45:0) after 1m0s
[07:17:00.129] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:45:0)
[07:17:00.129] Timer tick, asking Buildbucket for the build status
[07:17:00.407] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:00.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:46:0) after 1m0s
[07:18:00.787] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:46:0)
[07:18:00.787] Timer tick, asking Buildbucket for the build status
[07:18:00.988] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:00.989] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:47:0) after 1m0s
[07:19:02.200] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:47:0)
[07:19:02.200] Timer tick, asking Buildbucket for the build status
[07:19:02.300] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:02.300] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:48:0) after 1m0s
[07:20:02.357] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:48:0)
[07:20:02.357] Timer tick, asking Buildbucket for the build status
[07:20:02.499] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:02.499] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:49:0) after 1m0s
[07:21:02.588] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:49:0)
[07:21:02.588] Timer tick, asking Buildbucket for the build status
[07:21:02.658] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:02.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:50:0) after 1m0s
[07:22:03.289] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:50:0)
[07:22:03.289] Timer tick, asking Buildbucket for the build status
[07:22:03.399] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:03.399] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:51:0) after 1m0s
[07:23:03.455] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:51:0)
[07:23:03.455] Timer tick, asking Buildbucket for the build status
[07:23:03.558] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:03.558] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:52:0) after 1m0s
[07:24:03.616] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:52:0)
[07:24:03.616] Timer tick, asking Buildbucket for the build status
[07:24:03.734] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:03.734] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:53:0) after 1m0s
[07:25:03.804] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:53:0)
[07:25:03.804] Timer tick, asking Buildbucket for the build status
[07:25:03.879] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:03.879] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:54:0) after 1m0s
[07:26:03.980] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:54:0)
[07:26:03.980] Timer tick, asking Buildbucket for the build status
[07:26:04.340] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:04.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:55:0) after 1m0s
[07:27:04.423] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:55:0)
[07:27:04.424] Timer tick, asking Buildbucket for the build status
[07:27:04.513] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:04.513] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:56:0) after 1m0s
[07:28:04.607] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:56:0)
[07:28:04.607] Timer tick, asking Buildbucket for the build status
[07:28:04.689] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:04.689] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:57:0) after 1m0s
[07:29:04.796] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:57:0)
[07:29:04.796] Timer tick, asking Buildbucket for the build status
[07:29:04.922] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:04.922] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:58:0) after 1m0s
[07:30:05.037] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:58:0)
[07:30:05.037] Timer tick, asking Buildbucket for the build status
[07:30:05.182] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:05.182] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:59:0) after 1m0s
[07:31:05.690] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:59:0)
[07:31:05.690] Timer tick, asking Buildbucket for the build status
[07:31:05.878] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:05.878] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:60:0) after 1m0s
[07:32:06.048] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:60:0)
[07:32:06.048] Timer tick, asking Buildbucket for the build status
[07:32:06.127] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:06.127] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:61:0) after 1m0s
[07:33:06.168] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:61:0)
[07:33:06.168] Timer tick, asking Buildbucket for the build status
[07:33:06.388] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:06.388] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:62:0) after 1m0s
[07:34:06.437] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:62:0)
[07:34:06.437] Timer tick, asking Buildbucket for the build status
[07:34:06.556] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:06.556] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:63:0) after 1m0s
[07:35:06.578] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:63:0)
[07:35:06.578] Timer tick, asking Buildbucket for the build status
[07:35:06.750] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:06.750] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:64:0) after 1m0s
[07:36:06.788] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:64:0)
[07:36:06.788] Timer tick, asking Buildbucket for the build status
[07:36:06.869] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:06.869] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:65:0) after 1m0s
[07:37:06.941] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:65:0)
[07:37:06.941] Timer tick, asking Buildbucket for the build status
[07:37:07.245] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:07.245] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:66:0) after 1m0s
[07:38:07.364] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:66:0)
[07:38:07.364] Timer tick, asking Buildbucket for the build status
[07:38:07.434] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:07.434] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:67:0) after 1m0s
[07:39:07.520] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:67:0)
[07:39:07.520] Timer tick, asking Buildbucket for the build status
[07:39:07.677] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:07.677] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:68:0) after 1m0s
[07:40:07.697] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:68:0)
[07:40:07.697] Timer tick, asking Buildbucket for the build status
[07:40:07.788] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:07.788] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:69:0) after 1m0s
[07:41:08.576] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:69:0)
[07:41:08.576] Timer tick, asking Buildbucket for the build status
[07:41:08.653] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:08.653] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:70:0) after 1m0s
[07:42:08.846] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:70:0)
[07:42:08.846] Timer tick, asking Buildbucket for the build status
[07:42:08.991] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:08.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:71:0) after 1m0s
[07:43:09.119] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:71:0)
[07:43:09.119] Timer tick, asking Buildbucket for the build status
[07:43:09.191] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:09.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:72:0) after 1m0s
[07:44:09.307] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:72:0)
[07:44:09.307] Timer tick, asking Buildbucket for the build status
[07:44:09.422] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:09.423] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:73:0) after 1m0s
[07:45:09.565] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:73:0)
[07:45:09.565] Timer tick, asking Buildbucket for the build status
[07:45:09.655] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:09.656] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:74:0) after 1m0s
[07:46:09.841] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:74:0)
[07:46:09.841] Timer tick, asking Buildbucket for the build status
[07:46:09.945] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:09.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:75:0) after 1m0s
[07:47:10.072] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:75:0)
[07:47:10.072] Timer tick, asking Buildbucket for the build status
[07:47:10.185] Build 8863586707796472944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:10.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9029016770019043632:76:0) after 1m0s
[07:47:35.114] Received PubSub notification, asking Buildbucket for the build status
[07:47:35.211] Build 8863586707796472944: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:47:35.211] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1605426453763659",
"created_by": "project:fuchsia",
"created_ts": "1605422027742216",
"id": "8863586707796472944",
"parameters_json": "{\"builder_name\": \"gcc-prod-trigger\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"9dd02fc063284f59994c095ce525e1b8934b0dc1\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@9dd02fc063284f59994c095ce525e1b8934b0dc1\", \"title\": \"9dd02fc063284f59994c095ce525e1b8934b0dc1\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/9dd02fc063284f59994c095ce525e1b8934b0dc1\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"9dd02fc063284f59994c095ce525e1b8934b0dc1\"}}",
"project": "fuchsia",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder\", \"git\", \"goma_v2\", \"symbol\", \"vpython\"], \"cores\": [\"2\"], \"cpu\": [\"x64\", \"x86\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"fuchsia-infra\"], \"gpu\": [\"none\"], \"id\": [\"fuchsia-prod-e2-2-ssd0-us-central1-a-0-mynz\"], \"image\": [\"fuchsia-debian-9-drawfork-v20201027-46d3aed\"], \"inside_docker\": [\"0\"], \"kvm\": [\"0\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-2\"], \"os\": [\"Debian\", \"Debian-9\", \"Debian-9.11\", \"Linux\"], \"pool\": [\"luci.fuchsia.prod\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5626-39642e9\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1605422038231171",
"status": "COMPLETED",
"status_changed_ts": "1605426454859637",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/9dd02fc063284f59994c095ce525e1b8934b0dc1",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/9dd02fc063284f59994c095ce525e1b8934b0dc1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029016770019043632",
"scheduler_job_id:fuchsia/gcc-prod-trigger-3e002780",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/fuchsia/buildbucket/cr-buildbucket.appspot.com/8863586707796472944/+/annotations",
"swarming_tag:luci_project:fuchsia",
"swarming_tag:os:Debian",
"swarming_tag:recipe_name:toolchain_trigger",
"swarming_tag:recipe_package:fuchsia/infra/recipe_bundles/fuchsia.googlesource.com/infra/recipes",
"swarming_task_id:4fe36da88b360e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605426454872103",
"url": "https://ci.chromium.org/b/8863586707796472944",
"utcnow_ts": "1605426455204528"
}
}
[07:47:35.211] Invocation finished in 1h13m48.973019129s with status SUCCEEDED