[06:33:57.235] New invocation is queued and will start shortly
[06:33:58.364] Starting the invocation (attempt 1)
[06:33:58.399] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:33:58.399] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:33:58.399] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9023671537485894960",
"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\":\"3034143dc6c78f6e298db7791e710041ab64ea02\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@3034143dc6c78f6e298db7791e710041ab64ea02\",\"title\":\"3034143dc6c78f6e298db7791e710041ab64ea02\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/3034143dc6c78f6e298db7791e710041ab64ea02\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"3034143dc6c78f6e298db7791e710041ab64ea02\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-prod-trigger",
"scheduler_invocation_id:9023671537485894960",
"scheduler_job_id:fuchsia/gcc-prod-trigger-3e002780",
"user_agent:luci-scheduler",
"buildset:commit/git/3034143dc6c78f6e298db7791e710041ab64ea02",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/3034143dc6c78f6e298db7791e710041ab64ea02",
"gitiles_ref:refs/heads/master"
]
}
[06:33:59.548] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1610519638587416",
"id": "8858241475407770288",
"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\": \"3034143dc6c78f6e298db7791e710041ab64ea02\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@3034143dc6c78f6e298db7791e710041ab64ea02\", \"title\": \"3034143dc6c78f6e298db7791e710041ab64ea02\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/3034143dc6c78f6e298db7791e710041ab64ea02\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"3034143dc6c78f6e298db7791e710041ab64ea02\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610519639253529",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/3034143dc6c78f6e298db7791e710041ab64ea02",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/3034143dc6c78f6e298db7791e710041ab64ea02",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023671537485894960",
"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/8858241475407770288/+/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": "1610519639253827",
"url": "https://ci.chromium.org/b/8858241475407770288",
"utcnow_ts": "1610519639527318"
}
}
[06:33:59.548] Task URL: https://ci.chromium.org/b/8858241475407770288
[06:33:59.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:2:0) after 1m0s
[06:34:18.260] Received PubSub notification, asking Buildbucket for the build status
[06:34:18.407] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:59.595] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:2:0)
[06:34:59.595] Timer tick, asking Buildbucket for the build status
[06:34:59.692] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:59.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:4:0) after 1m0s
[06:35:59.732] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:4:0)
[06:35:59.732] Timer tick, asking Buildbucket for the build status
[06:35:59.799] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:59.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:5:0) after 1m0s
[06:36:59.824] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:5:0)
[06:36:59.824] Timer tick, asking Buildbucket for the build status
[06:36:59.901] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:59.901] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:6:0) after 1m0s
[06:37:59.985] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:6:0)
[06:37:59.985] Timer tick, asking Buildbucket for the build status
[06:38:00.122] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:00.122] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:7:0) after 1m0s
[06:39:00.142] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:7:0)
[06:39:00.142] Timer tick, asking Buildbucket for the build status
[06:39:00.228] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:00.228] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:8:0) after 1m0s
[06:40:00.324] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:8:0)
[06:40:00.324] Timer tick, asking Buildbucket for the build status
[06:40:00.443] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:00.443] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:9:0) after 1m0s
[06:41:00.491] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:9:0)
[06:41:00.491] Timer tick, asking Buildbucket for the build status
[06:41:00.788] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:00.788] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:10:0) after 1m0s
[06:42:01.216] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:10:0)
[06:42:01.216] Timer tick, asking Buildbucket for the build status
[06:42:01.288] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:01.288] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:11:0) after 1m0s
[06:43:01.865] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:11:0)
[06:43:01.865] Timer tick, asking Buildbucket for the build status
[06:43:02.010] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:02.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:12:0) after 1m0s
[06:44:02.143] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:12:0)
[06:44:02.143] Timer tick, asking Buildbucket for the build status
[06:44:02.246] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:02.246] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:13:0) after 1m0s
[06:45:02.565] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:13:0)
[06:45:02.565] Timer tick, asking Buildbucket for the build status
[06:45:02.757] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:02.757] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:14:0) after 1m0s
[06:46:03.140] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:14:0)
[06:46:03.140] Timer tick, asking Buildbucket for the build status
[06:46:03.211] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:03.211] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:15:0) after 1m0s
[06:47:03.244] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:15:0)
[06:47:03.244] Timer tick, asking Buildbucket for the build status
[06:47:03.450] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:03.450] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:16:0) after 1m0s
[06:48:03.517] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:16:0)
[06:48:03.517] Timer tick, asking Buildbucket for the build status
[06:48:03.608] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:03.608] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:17:0) after 1m0s
[06:49:03.676] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:17:0)
[06:49:03.676] Timer tick, asking Buildbucket for the build status
[06:49:03.813] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:03.813] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:18:0) after 1m0s
[06:50:03.855] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:18:0)
[06:50:03.855] Timer tick, asking Buildbucket for the build status
[06:50:03.948] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:03.948] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:19:0) after 1m0s
[06:51:04.006] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:19:0)
[06:51:04.006] Timer tick, asking Buildbucket for the build status
[06:51:04.105] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:04.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:20:0) after 1m0s
[06:52:04.178] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:20:0)
[06:52:04.178] Timer tick, asking Buildbucket for the build status
[06:52:04.264] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:04.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:21:0) after 1m0s
[06:53:04.291] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:21:0)
[06:53:04.291] Timer tick, asking Buildbucket for the build status
[06:53:04.347] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:04.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:22:0) after 1m0s
[06:54:04.381] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:22:0)
[06:54:04.381] Timer tick, asking Buildbucket for the build status
[06:54:04.531] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:04.531] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:23:0) after 1m0s
[06:55:04.549] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:23:0)
[06:55:04.549] Timer tick, asking Buildbucket for the build status
[06:55:04.604] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:04.604] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:24:0) after 1m0s
[06:56:04.657] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:24:0)
[06:56:04.657] Timer tick, asking Buildbucket for the build status
[06:56:04.897] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:04.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:25:0) after 1m0s
[06:57:04.921] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:25:0)
[06:57:04.921] Timer tick, asking Buildbucket for the build status
[06:57:05.007] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:05.007] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:26:0) after 1m0s
[06:58:05.053] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:26:0)
[06:58:05.053] Timer tick, asking Buildbucket for the build status
[06:58:05.145] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:05.145] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:27:0) after 1m0s
[06:59:05.192] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:27:0)
[06:59:05.192] Timer tick, asking Buildbucket for the build status
[06:59:05.353] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:05.353] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:28:0) after 1m0s
[07:00:05.403] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:28:0)
[07:00:05.403] Timer tick, asking Buildbucket for the build status
[07:00:05.571] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:05.571] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:29:0) after 1m0s
[07:01:05.944] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:29:0)
[07:01:05.944] Timer tick, asking Buildbucket for the build status
[07:01:06.006] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:06.006] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:30:0) after 1m0s
[07:02:06.065] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:30:0)
[07:02:06.065] Timer tick, asking Buildbucket for the build status
[07:02:06.132] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:06.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:31:0) after 1m0s
[07:03:06.175] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:31:0)
[07:03:06.175] Timer tick, asking Buildbucket for the build status
[07:03:06.418] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:06.418] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:32:0) after 1m0s
[07:04:06.603] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:32:0)
[07:04:06.603] Timer tick, asking Buildbucket for the build status
[07:04:07.099] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:07.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:33:0) after 1m0s
[07:05:07.178] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:33:0)
[07:05:07.178] Timer tick, asking Buildbucket for the build status
[07:05:07.265] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:07.265] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:34:0) after 1m0s
[07:06:07.291] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:34:0)
[07:06:07.291] Timer tick, asking Buildbucket for the build status
[07:06:07.362] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:07.362] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:35:0) after 1m0s
[07:07:07.546] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:35:0)
[07:07:07.546] Timer tick, asking Buildbucket for the build status
[07:07:07.622] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:07.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:36:0) after 1m0s
[07:08:07.810] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:36:0)
[07:08:07.810] Timer tick, asking Buildbucket for the build status
[07:08:07.869] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:07.869] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:37:0) after 1m0s
[07:09:08.093] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:37:0)
[07:09:08.093] Timer tick, asking Buildbucket for the build status
[07:09:08.224] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:08.224] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:38:0) after 1m0s
[07:10:08.526] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:38:0)
[07:10:08.526] Timer tick, asking Buildbucket for the build status
[07:10:08.782] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:08.782] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:39:0) after 1m0s
[07:11:09.057] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:39:0)
[07:11:09.057] Timer tick, asking Buildbucket for the build status
[07:11:09.131] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:09.131] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:40:0) after 1m0s
[07:12:09.464] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:40:0)
[07:12:09.464] Timer tick, asking Buildbucket for the build status
[07:12:09.693] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:09.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:41:0) after 1m0s
[07:13:09.839] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:41:0)
[07:13:09.839] Timer tick, asking Buildbucket for the build status
[07:13:09.910] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:09.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:42:0) after 1m0s
[07:14:10.135] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:42:0)
[07:14:10.135] Timer tick, asking Buildbucket for the build status
[07:14:10.333] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:10.333] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:43:0) after 1m0s
[07:15:10.421] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:43:0)
[07:15:10.421] Timer tick, asking Buildbucket for the build status
[07:15:10.494] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:10.494] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:44:0) after 1m0s
[07:16:10.578] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:44:0)
[07:16:10.578] Timer tick, asking Buildbucket for the build status
[07:16:10.677] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:10.677] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:45:0) after 1m0s
[07:17:10.702] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:45:0)
[07:17:10.702] Timer tick, asking Buildbucket for the build status
[07:17:10.816] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:10.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:46:0) after 1m0s
[07:18:10.889] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:46:0)
[07:18:10.889] Timer tick, asking Buildbucket for the build status
[07:18:11.049] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:11.050] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:47:0) after 1m0s
[07:19:11.163] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:47:0)
[07:19:11.163] Timer tick, asking Buildbucket for the build status
[07:19:11.286] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:11.286] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:48:0) after 1m0s
[07:20:11.374] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:48:0)
[07:20:11.374] Timer tick, asking Buildbucket for the build status
[07:20:11.589] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:11.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:49:0) after 1m0s
[07:21:11.636] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:49:0)
[07:21:11.636] Timer tick, asking Buildbucket for the build status
[07:21:11.712] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:11.712] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:50:0) after 1m0s
[07:22:11.752] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:50:0)
[07:22:11.752] Timer tick, asking Buildbucket for the build status
[07:22:11.835] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:11.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:51:0) after 1m0s
[07:23:11.910] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:51:0)
[07:23:11.910] Timer tick, asking Buildbucket for the build status
[07:23:11.976] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:11.976] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:52:0) after 1m0s
[07:24:12.000] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:52:0)
[07:24:12.000] Timer tick, asking Buildbucket for the build status
[07:24:12.143] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:12.143] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:53:0) after 1m0s
[07:25:12.286] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:53:0)
[07:25:12.286] Timer tick, asking Buildbucket for the build status
[07:25:12.374] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:12.374] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:54:0) after 1m0s
[07:26:12.389] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:54:0)
[07:26:12.389] Timer tick, asking Buildbucket for the build status
[07:26:12.604] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:12.604] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:55:0) after 1m0s
[07:27:12.591] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:55:0)
[07:27:12.591] Timer tick, asking Buildbucket for the build status
[07:27:12.650] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:12.650] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:56:0) after 1m0s
[07:28:12.658] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:56:0)
[07:28:12.659] Timer tick, asking Buildbucket for the build status
[07:28:12.731] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:12.731] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:57:0) after 1m0s
[07:29:12.777] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:57:0)
[07:29:12.777] Timer tick, asking Buildbucket for the build status
[07:29:12.989] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:12.989] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:58:0) after 1m0s
[07:30:13.087] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:58:0)
[07:30:13.087] Timer tick, asking Buildbucket for the build status
[07:30:13.329] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:13.329] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:59:0) after 1m0s
[07:31:13.425] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:59:0)
[07:31:13.425] Timer tick, asking Buildbucket for the build status
[07:31:13.608] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:13.609] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:60:0) after 1m0s
[07:32:13.616] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:60:0)
[07:32:13.616] Timer tick, asking Buildbucket for the build status
[07:32:13.892] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:13.892] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:61:0) after 1m0s
[07:33:13.988] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:61:0)
[07:33:13.988] Timer tick, asking Buildbucket for the build status
[07:33:14.099] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:14.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:62:0) after 1m0s
[07:34:14.147] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:62:0)
[07:34:14.147] Timer tick, asking Buildbucket for the build status
[07:34:14.276] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:14.276] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:63:0) after 1m0s
[07:35:14.325] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:63:0)
[07:35:14.325] Timer tick, asking Buildbucket for the build status
[07:35:14.533] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:14.533] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:64:0) after 1m0s
[07:36:14.558] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:64:0)
[07:36:14.558] Timer tick, asking Buildbucket for the build status
[07:36:14.949] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:14.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:65:0) after 1m0s
[07:37:14.992] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:65:0)
[07:37:14.992] Timer tick, asking Buildbucket for the build status
[07:37:15.058] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:15.058] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:66:0) after 1m0s
[07:38:15.113] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:66:0)
[07:38:15.113] Timer tick, asking Buildbucket for the build status
[07:38:15.173] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:15.173] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:67:0) after 1m0s
[07:39:15.197] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:67:0)
[07:39:15.197] Timer tick, asking Buildbucket for the build status
[07:39:15.305] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:15.305] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:68:0) after 1m0s
[07:40:15.307] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:68:0)
[07:40:15.307] Timer tick, asking Buildbucket for the build status
[07:40:15.399] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:15.399] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:69:0) after 1m0s
[07:41:15.422] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:69:0)
[07:41:15.422] Timer tick, asking Buildbucket for the build status
[07:41:15.570] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:15.571] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:70:0) after 1m0s
[07:42:15.603] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:70:0)
[07:42:15.603] Timer tick, asking Buildbucket for the build status
[07:42:15.679] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:15.679] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:71:0) after 1m0s
[07:43:15.729] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:71:0)
[07:43:15.729] Timer tick, asking Buildbucket for the build status
[07:43:15.805] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:15.805] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:72:0) after 1m0s
[07:44:15.830] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:72:0)
[07:44:15.830] Timer tick, asking Buildbucket for the build status
[07:44:16.111] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:16.112] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:73:0) after 1m0s
[07:45:16.204] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:73:0)
[07:45:16.204] Timer tick, asking Buildbucket for the build status
[07:45:16.275] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:16.275] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:74:0) after 1m0s
[07:46:16.309] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:74:0)
[07:46:16.309] Timer tick, asking Buildbucket for the build status
[07:46:16.365] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:16.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:75:0) after 1m0s
[07:47:16.396] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:75:0)
[07:47:16.396] Timer tick, asking Buildbucket for the build status
[07:47:16.476] Build 8858241475407770288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:16.476] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023671537485894960:76:0) after 1m0s
[07:47:46.102] Received PubSub notification, asking Buildbucket for the build status
[07:47:46.182] Build 8858241475407770288: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:47:46.182] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1610524064969153",
"created_by": "project:fuchsia",
"created_ts": "1610519638587416",
"id": "8858241475407770288",
"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\": \"3034143dc6c78f6e298db7791e710041ab64ea02\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@3034143dc6c78f6e298db7791e710041ab64ea02\", \"title\": \"3034143dc6c78f6e298db7791e710041ab64ea02\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/3034143dc6c78f6e298db7791e710041ab64ea02\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"3034143dc6c78f6e298db7791e710041ab64ea02\"}}",
"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-b-1-d38d\"], \"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\": [\"5661-c6f6250\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1610519657097835",
"status": "COMPLETED",
"status_changed_ts": "1610524065694269",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/3034143dc6c78f6e298db7791e710041ab64ea02",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/3034143dc6c78f6e298db7791e710041ab64ea02",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023671537485894960",
"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/8858241475407770288/+/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:511344ff3a2f1210",
"user_agent:luci-scheduler"
],
"updated_ts": "1610524065726200",
"url": "https://ci.chromium.org/b/8858241475407770288",
"utcnow_ts": "1610524066172954"
}
}
[07:47:46.183] Invocation finished in 1h13m48.961823192s with status SUCCEEDED