[06:33:51.629] New invocation is queued and will start shortly
[06:33:52.919] Starting the invocation (attempt 1)
[06:33:52.956] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:33:52.956] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:33:52.956] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9020138261684661264",
"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\":\"93993f67849234cff651542c3d4d9f0f3d2fa651\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@93993f67849234cff651542c3d4d9f0f3d2fa651\",\"title\":\"93993f67849234cff651542c3d4d9f0f3d2fa651\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/93993f67849234cff651542c3d4d9f0f3d2fa651\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"89753bbf8102edc2aa4262a4d43f1a71a10e34f3\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@89753bbf8102edc2aa4262a4d43f1a71a10e34f3\",\"title\":\"89753bbf8102edc2aa4262a4d43f1a71a10e34f3\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/89753bbf8102edc2aa4262a4d43f1a71a10e34f3\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"89753bbf8102edc2aa4262a4d43f1a71a10e34f3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-prod-trigger",
"scheduler_invocation_id:9020138261684661264",
"scheduler_job_id:fuchsia/gcc-prod-trigger-3e002780",
"user_agent:luci-scheduler",
"buildset:commit/git/89753bbf8102edc2aa4262a4d43f1a71a10e34f3",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/89753bbf8102edc2aa4262a4d43f1a71a10e34f3",
"gitiles_ref:refs/heads/master"
]
}
[06:33:54.176] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1613889233121570",
"id": "8854708199449278224",
"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\": \"93993f67849234cff651542c3d4d9f0f3d2fa651\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@93993f67849234cff651542c3d4d9f0f3d2fa651\", \"title\": \"93993f67849234cff651542c3d4d9f0f3d2fa651\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/93993f67849234cff651542c3d4d9f0f3d2fa651\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"89753bbf8102edc2aa4262a4d43f1a71a10e34f3\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@89753bbf8102edc2aa4262a4d43f1a71a10e34f3\", \"title\": \"89753bbf8102edc2aa4262a4d43f1a71a10e34f3\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/89753bbf8102edc2aa4262a4d43f1a71a10e34f3\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"89753bbf8102edc2aa4262a4d43f1a71a10e34f3\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613889233838918",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/89753bbf8102edc2aa4262a4d43f1a71a10e34f3",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/89753bbf8102edc2aa4262a4d43f1a71a10e34f3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020138261684661264",
"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/8854708199449278224/+/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": "1613889233839101",
"url": "https://ci.chromium.org/b/8854708199449278224",
"utcnow_ts": "1613889234139378"
}
}
[06:33:54.176] Task URL: https://ci.chromium.org/b/8854708199449278224
[06:33:54.176] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:2:0) after 1m0s
[06:33:56.742] Received PubSub notification, asking Buildbucket for the build status
[06:33:56.909] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:54.449] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:2:0)
[06:34:54.449] Timer tick, asking Buildbucket for the build status
[06:34:54.571] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:54.571] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:4:0) after 1m0s
[06:35:54.717] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:4:0)
[06:35:54.717] Timer tick, asking Buildbucket for the build status
[06:35:54.827] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:54.827] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:5:0) after 1m0s
[06:36:54.924] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:5:0)
[06:36:54.924] Timer tick, asking Buildbucket for the build status
[06:36:55.007] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:55.007] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:6:0) after 1m0s
[06:37:55.063] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:6:0)
[06:37:55.063] Timer tick, asking Buildbucket for the build status
[06:37:55.137] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:55.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:7:0) after 1m0s
[06:38:55.213] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:7:0)
[06:38:55.213] Timer tick, asking Buildbucket for the build status
[06:38:55.402] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:55.402] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:8:0) after 1m0s
[06:39:55.465] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:8:0)
[06:39:55.465] Timer tick, asking Buildbucket for the build status
[06:39:55.619] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:55.619] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:9:0) after 1m0s
[06:40:55.650] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:9:0)
[06:40:55.650] Timer tick, asking Buildbucket for the build status
[06:40:56.021] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:56.021] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:10:0) after 1m0s
[06:41:56.080] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:10:0)
[06:41:56.080] Timer tick, asking Buildbucket for the build status
[06:41:56.377] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:56.377] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:11:0) after 1m0s
[06:42:56.442] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:11:0)
[06:42:56.442] Timer tick, asking Buildbucket for the build status
[06:42:56.610] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:56.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:12:0) after 1m0s
[06:43:56.584] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:12:0)
[06:43:56.584] Timer tick, asking Buildbucket for the build status
[06:43:56.662] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:56.662] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:13:0) after 1m0s
[06:44:56.651] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:13:0)
[06:44:56.651] Timer tick, asking Buildbucket for the build status
[06:44:56.937] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:56.937] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:14:0) after 1m0s
[06:45:57.004] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:14:0)
[06:45:57.004] Timer tick, asking Buildbucket for the build status
[06:45:57.199] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:57.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:15:0) after 1m0s
[06:46:57.214] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:15:0)
[06:46:57.214] Timer tick, asking Buildbucket for the build status
[06:46:57.830] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:57.830] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:16:0) after 1m0s
[06:47:57.902] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:16:0)
[06:47:57.902] Timer tick, asking Buildbucket for the build status
[06:47:58.047] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:58.047] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:17:0) after 1m0s
[06:48:58.100] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:17:0)
[06:48:58.100] Timer tick, asking Buildbucket for the build status
[06:48:58.600] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:58.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:18:0) after 1m0s
[06:49:58.628] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:18:0)
[06:49:58.628] Timer tick, asking Buildbucket for the build status
[06:49:58.814] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:58.814] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:19:0) after 1m0s
[06:50:58.829] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:19:0)
[06:50:58.829] Timer tick, asking Buildbucket for the build status
[06:50:58.909] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:58.909] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:20:0) after 1m0s
[06:51:58.968] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:20:0)
[06:51:58.968] Timer tick, asking Buildbucket for the build status
[06:51:59.064] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:59.064] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:21:0) after 1m0s
[06:52:59.090] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:21:0)
[06:52:59.090] Timer tick, asking Buildbucket for the build status
[06:52:59.167] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:59.167] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:22:0) after 1m0s
[06:53:59.197] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:22:0)
[06:53:59.197] Timer tick, asking Buildbucket for the build status
[06:53:59.496] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:59.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:23:0) after 1m0s
[06:54:59.534] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:23:0)
[06:54:59.534] Timer tick, asking Buildbucket for the build status
[06:54:59.710] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:59.710] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:24:0) after 1m0s
[06:55:59.727] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:24:0)
[06:55:59.727] Timer tick, asking Buildbucket for the build status
[06:55:59.805] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:59.805] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:25:0) after 1m0s
[06:56:59.860] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:25:0)
[06:56:59.860] Timer tick, asking Buildbucket for the build status
[06:56:59.944] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:59.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:26:0) after 1m0s
[06:57:59.914] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:26:0)
[06:57:59.914] Timer tick, asking Buildbucket for the build status
[06:57:59.985] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:59.985] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:27:0) after 1m0s
[06:59:00.023] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:27:0)
[06:59:00.023] Timer tick, asking Buildbucket for the build status
[06:59:00.455] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:00.455] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:28:0) after 1m0s
[07:00:00.875] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:28:0)
[07:00:00.875] Timer tick, asking Buildbucket for the build status
[07:00:00.970] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:00.970] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:29:0) after 1m0s
[07:01:01.060] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:29:0)
[07:01:01.060] Timer tick, asking Buildbucket for the build status
[07:01:01.159] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:01.159] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:30:0) after 1m0s
[07:02:01.388] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:30:0)
[07:02:01.388] Timer tick, asking Buildbucket for the build status
[07:02:01.610] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:01.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:31:0) after 1m0s
[07:03:01.596] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:31:0)
[07:03:01.596] Timer tick, asking Buildbucket for the build status
[07:03:01.682] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:01.682] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:32:0) after 1m0s
[07:04:01.712] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:32:0)
[07:04:01.712] Timer tick, asking Buildbucket for the build status
[07:04:02.308] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:02.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:33:0) after 1m0s
[07:05:02.425] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:33:0)
[07:05:02.425] Timer tick, asking Buildbucket for the build status
[07:05:02.494] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:02.494] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:34:0) after 1m0s
[07:06:02.473] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:34:0)
[07:06:02.473] Timer tick, asking Buildbucket for the build status
[07:06:02.725] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:02.725] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:35:0) after 1m0s
[07:07:02.824] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:35:0)
[07:07:02.824] Timer tick, asking Buildbucket for the build status
[07:07:02.900] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:02.900] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:36:0) after 1m0s
[07:08:02.926] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:36:0)
[07:08:02.926] Timer tick, asking Buildbucket for the build status
[07:08:03.106] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:03.106] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:37:0) after 1m0s
[07:09:03.174] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:37:0)
[07:09:03.174] Timer tick, asking Buildbucket for the build status
[07:09:03.271] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:03.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:38:0) after 1m0s
[07:10:03.311] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:38:0)
[07:10:03.311] Timer tick, asking Buildbucket for the build status
[07:10:03.405] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:03.405] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:39:0) after 1m0s
[07:11:03.455] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:39:0)
[07:11:03.455] Timer tick, asking Buildbucket for the build status
[07:11:03.530] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:03.530] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:40:0) after 1m0s
[07:12:03.576] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:40:0)
[07:12:03.576] Timer tick, asking Buildbucket for the build status
[07:12:03.654] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:03.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:41:0) after 1m0s
[07:13:03.696] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:41:0)
[07:13:03.696] Timer tick, asking Buildbucket for the build status
[07:13:03.841] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:03.841] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:42:0) after 1m0s
[07:14:03.907] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:42:0)
[07:14:03.907] Timer tick, asking Buildbucket for the build status
[07:14:04.014] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:04.014] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:43:0) after 1m0s
[07:15:04.121] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:43:0)
[07:15:04.121] Timer tick, asking Buildbucket for the build status
[07:15:04.599] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:04.599] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:44:0) after 1m0s
[07:16:04.664] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:44:0)
[07:16:04.664] Timer tick, asking Buildbucket for the build status
[07:16:04.741] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:04.741] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:45:0) after 1m0s
[07:17:05.037] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:45:0)
[07:17:05.037] Timer tick, asking Buildbucket for the build status
[07:17:05.112] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:05.112] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:46:0) after 1m0s
[07:18:05.344] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:46:0)
[07:18:05.344] Timer tick, asking Buildbucket for the build status
[07:18:05.697] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:05.697] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:47:0) after 1m0s
[07:19:05.836] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:47:0)
[07:19:05.836] Timer tick, asking Buildbucket for the build status
[07:19:05.942] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:05.942] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:48:0) after 1m0s
[07:20:06.231] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:48:0)
[07:20:06.231] Timer tick, asking Buildbucket for the build status
[07:20:06.306] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:06.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:49:0) after 1m0s
[07:21:06.545] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:49:0)
[07:21:06.545] Timer tick, asking Buildbucket for the build status
[07:21:06.666] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:06.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:50:0) after 1m0s
[07:22:06.785] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:50:0)
[07:22:06.785] Timer tick, asking Buildbucket for the build status
[07:22:06.849] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:06.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:51:0) after 1m0s
[07:23:06.984] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:51:0)
[07:23:06.984] Timer tick, asking Buildbucket for the build status
[07:23:08.080] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:08.080] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:52:0) after 1m0s
[07:24:08.139] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:52:0)
[07:24:08.139] Timer tick, asking Buildbucket for the build status
[07:24:08.424] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:08.424] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:53:0) after 1m0s
[07:25:08.447] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:53:0)
[07:25:08.447] Timer tick, asking Buildbucket for the build status
[07:25:08.724] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:08.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:54:0) after 1m0s
[07:26:08.756] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:54:0)
[07:26:08.756] Timer tick, asking Buildbucket for the build status
[07:26:09.105] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:09.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:55:0) after 1m0s
[07:27:09.226] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:55:0)
[07:27:09.226] Timer tick, asking Buildbucket for the build status
[07:27:09.296] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:09.296] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:56:0) after 1m0s
[07:28:09.386] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:56:0)
[07:28:09.386] Timer tick, asking Buildbucket for the build status
[07:28:09.463] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:09.463] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:57:0) after 1m0s
[07:29:09.621] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:57:0)
[07:29:09.621] Timer tick, asking Buildbucket for the build status
[07:29:09.755] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:09.756] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:58:0) after 1m0s
[07:30:09.771] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:58:0)
[07:30:09.771] Timer tick, asking Buildbucket for the build status
[07:30:09.844] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:09.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:59:0) after 1m0s
[07:31:10.447] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:59:0)
[07:31:10.447] Timer tick, asking Buildbucket for the build status
[07:31:10.627] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:10.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:60:0) after 1m0s
[07:32:10.600] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:60:0)
[07:32:10.600] Timer tick, asking Buildbucket for the build status
[07:32:10.667] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:10.667] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:61:0) after 1m0s
[07:33:10.746] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:61:0)
[07:33:10.746] Timer tick, asking Buildbucket for the build status
[07:33:11.029] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:11.029] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:62:0) after 1m0s
[07:34:11.219] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:62:0)
[07:34:11.219] Timer tick, asking Buildbucket for the build status
[07:34:11.327] Build 8854708199449278224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:11.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020138261684661264:63:0) after 1m0s
[07:34:21.642] Received PubSub notification, asking Buildbucket for the build status
[07:34:21.707] Build 8854708199449278224: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:34:21.707] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1613892860956826",
"created_by": "project:fuchsia",
"created_ts": "1613889233121570",
"id": "8854708199449278224",
"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\": \"93993f67849234cff651542c3d4d9f0f3d2fa651\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@93993f67849234cff651542c3d4d9f0f3d2fa651\", \"title\": \"93993f67849234cff651542c3d4d9f0f3d2fa651\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/93993f67849234cff651542c3d4d9f0f3d2fa651\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"89753bbf8102edc2aa4262a4d43f1a71a10e34f3\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@89753bbf8102edc2aa4262a4d43f1a71a10e34f3\", \"title\": \"89753bbf8102edc2aa4262a4d43f1a71a10e34f3\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/89753bbf8102edc2aa4262a4d43f1a71a10e34f3\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"89753bbf8102edc2aa4262a4d43f1a71a10e34f3\"}}",
"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-d805\"], \"image\": [\"fuchsia-debian-9-v20210121-f1877f1\"], \"inside_docker\": [\"0\"], \"kvm\": [\"0\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-2\"], \"os\": [\"Debian\", \"Debian-9\", \"Debian-9.13\", \"Linux\"], \"pool\": [\"luci.fuchsia.prod\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5706-397711c\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1613889236183346",
"status": "COMPLETED",
"status_changed_ts": "1613889236522559",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/89753bbf8102edc2aa4262a4d43f1a71a10e34f3",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/89753bbf8102edc2aa4262a4d43f1a71a10e34f3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020138261684661264",
"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/8854708199449278224/+/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:51dc1ceed8cdce10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613892860997235",
"url": "https://ci.chromium.org/b/8854708199449278224",
"utcnow_ts": "1613892861700719"
}
}
[07:34:21.707] Invocation finished in 1h0m30.100237926s with status SUCCEEDED