[06:33:52.886] New invocation is queued and will start shortly
[06:33:54.684] Starting the invocation (attempt 1)
[06:33:54.720] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:33:54.721] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:33:54.721] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9030194523631713168",
"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\":\"b1a92c635c1ec10fd703302ce1fc4ab3a8515a04\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@b1a92c635c1ec10fd703302ce1fc4ab3a8515a04\",\"title\":\"b1a92c635c1ec10fd703302ce1fc4ab3a8515a04\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/b1a92c635c1ec10fd703302ce1fc4ab3a8515a04\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"8807d3127cb4b9199a3d5a16aa2851cc28e9826c\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@8807d3127cb4b9199a3d5a16aa2851cc28e9826c\",\"title\":\"8807d3127cb4b9199a3d5a16aa2851cc28e9826c\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/8807d3127cb4b9199a3d5a16aa2851cc28e9826c\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"8807d3127cb4b9199a3d5a16aa2851cc28e9826c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-prod-trigger",
"scheduler_invocation_id:9030194523631713168",
"scheduler_job_id:fuchsia/gcc-prod-trigger-3e002780",
"user_agent:luci-scheduler",
"buildset:commit/git/8807d3127cb4b9199a3d5a16aa2851cc28e9826c",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/8807d3127cb4b9199a3d5a16aa2851cc28e9826c",
"gitiles_ref:refs/heads/master"
]
}
[06:33:55.257] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1604298834804808",
"id": "8864764460954313712",
"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\": \"b1a92c635c1ec10fd703302ce1fc4ab3a8515a04\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@b1a92c635c1ec10fd703302ce1fc4ab3a8515a04\", \"title\": \"b1a92c635c1ec10fd703302ce1fc4ab3a8515a04\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/b1a92c635c1ec10fd703302ce1fc4ab3a8515a04\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"8807d3127cb4b9199a3d5a16aa2851cc28e9826c\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@8807d3127cb4b9199a3d5a16aa2851cc28e9826c\", \"title\": \"8807d3127cb4b9199a3d5a16aa2851cc28e9826c\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/8807d3127cb4b9199a3d5a16aa2851cc28e9826c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"8807d3127cb4b9199a3d5a16aa2851cc28e9826c\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604298835138638",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/8807d3127cb4b9199a3d5a16aa2851cc28e9826c",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/8807d3127cb4b9199a3d5a16aa2851cc28e9826c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030194523631713168",
"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/8864764460954313712/+/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": "1604298835138748",
"url": "https://ci.chromium.org/b/8864764460954313712",
"utcnow_ts": "1604298835250039"
}
}
[06:33:55.257] Task URL: https://ci.chromium.org/b/8864764460954313712
[06:33:55.257] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:2:0) after 1m0s
[06:33:57.261] Received PubSub notification, asking Buildbucket for the build status
[06:33:57.463] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:55.544] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:2:0)
[06:34:55.544] Timer tick, asking Buildbucket for the build status
[06:34:55.679] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:55.679] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:4:0) after 1m0s
[06:35:55.713] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:4:0)
[06:35:55.713] Timer tick, asking Buildbucket for the build status
[06:35:55.784] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:55.784] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:5:0) after 1m0s
[06:36:55.808] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:5:0)
[06:36:55.808] Timer tick, asking Buildbucket for the build status
[06:36:55.874] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:55.874] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:6:0) after 1m0s
[06:37:55.947] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:6:0)
[06:37:55.947] Timer tick, asking Buildbucket for the build status
[06:37:56.010] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:56.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:7:0) after 1m0s
[06:38:56.091] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:7:0)
[06:38:56.091] Timer tick, asking Buildbucket for the build status
[06:38:56.211] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:56.211] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:8:0) after 1m0s
[06:39:56.330] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:8:0)
[06:39:56.330] Timer tick, asking Buildbucket for the build status
[06:39:56.437] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:56.437] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:9:0) after 1m0s
[06:40:56.450] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:9:0)
[06:40:56.450] Timer tick, asking Buildbucket for the build status
[06:40:56.707] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:56.707] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:10:0) after 1m0s
[06:41:56.731] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:10:0)
[06:41:56.731] Timer tick, asking Buildbucket for the build status
[06:41:57.120] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:57.120] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:11:0) after 1m0s
[06:42:57.124] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:11:0)
[06:42:57.124] Timer tick, asking Buildbucket for the build status
[06:42:57.203] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:57.203] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:12:0) after 1m0s
[06:43:57.361] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:12:0)
[06:43:57.361] Timer tick, asking Buildbucket for the build status
[06:43:58.106] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:58.107] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:13:0) after 1m0s
[06:44:58.184] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:13:0)
[06:44:58.184] Timer tick, asking Buildbucket for the build status
[06:44:58.592] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:58.592] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:14:0) after 1m0s
[06:45:58.621] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:14:0)
[06:45:58.621] Timer tick, asking Buildbucket for the build status
[06:45:58.819] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:58.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:15:0) after 1m0s
[06:46:58.962] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:15:0)
[06:46:58.962] Timer tick, asking Buildbucket for the build status
[06:46:59.266] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:59.266] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:16:0) after 1m0s
[06:47:59.437] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:16:0)
[06:47:59.437] Timer tick, asking Buildbucket for the build status
[06:47:59.516] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:59.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:17:0) after 1m0s
[06:48:59.574] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:17:0)
[06:48:59.574] Timer tick, asking Buildbucket for the build status
[06:48:59.774] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:59.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:18:0) after 1m0s
[06:49:59.799] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:18:0)
[06:49:59.799] Timer tick, asking Buildbucket for the build status
[06:49:59.861] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:59.861] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:19:0) after 1m0s
[06:50:59.937] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:19:0)
[06:50:59.937] Timer tick, asking Buildbucket for the build status
[06:51:00.206] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:00.206] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:20:0) after 1m0s
[06:52:01.461] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:20:0)
[06:52:01.461] Timer tick, asking Buildbucket for the build status
[06:52:01.545] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:01.545] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:21:0) after 1m0s
[06:53:01.611] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:21:0)
[06:53:01.611] Timer tick, asking Buildbucket for the build status
[06:53:01.710] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:01.710] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:22:0) after 1m0s
[06:54:02.221] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:22:0)
[06:54:02.221] Timer tick, asking Buildbucket for the build status
[06:54:02.382] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:02.382] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:23:0) after 1m0s
[06:55:02.435] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:23:0)
[06:55:02.435] Timer tick, asking Buildbucket for the build status
[06:55:02.599] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:02.599] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:24:0) after 1m0s
[06:56:02.618] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:24:0)
[06:56:02.618] Timer tick, asking Buildbucket for the build status
[06:56:02.779] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:02.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:25:0) after 1m0s
[06:57:02.872] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:25:0)
[06:57:02.872] Timer tick, asking Buildbucket for the build status
[06:57:02.951] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:02.951] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:26:0) after 1m0s
[06:58:03.021] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:26:0)
[06:58:03.021] Timer tick, asking Buildbucket for the build status
[06:58:03.098] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:03.098] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:27:0) after 1m0s
[06:59:03.194] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:27:0)
[06:59:03.194] Timer tick, asking Buildbucket for the build status
[06:59:03.304] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:03.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:28:0) after 1m0s
[07:00:04.019] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:28:0)
[07:00:04.019] Timer tick, asking Buildbucket for the build status
[07:00:04.104] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:04.104] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:29:0) after 1m0s
[07:01:04.209] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:29:0)
[07:01:04.209] Timer tick, asking Buildbucket for the build status
[07:01:05.406] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:05.406] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:30:0) after 1m0s
[07:02:05.568] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:30:0)
[07:02:05.568] Timer tick, asking Buildbucket for the build status
[07:02:05.737] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:05.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:31:0) after 1m0s
[07:03:05.774] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:31:0)
[07:03:05.774] Timer tick, asking Buildbucket for the build status
[07:03:05.887] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:05.887] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:32:0) after 1m0s
[07:04:06.035] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:32:0)
[07:04:06.035] Timer tick, asking Buildbucket for the build status
[07:04:06.145] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:06.145] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:33:0) after 1m0s
[07:05:06.216] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:33:0)
[07:05:06.216] Timer tick, asking Buildbucket for the build status
[07:05:06.328] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:06.328] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:34:0) after 1m0s
[07:06:06.366] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:34:0)
[07:06:06.366] Timer tick, asking Buildbucket for the build status
[07:06:06.429] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:06.429] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:35:0) after 1m0s
[07:07:06.490] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:35:0)
[07:07:06.490] Timer tick, asking Buildbucket for the build status
[07:07:06.731] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:06.731] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:36:0) after 1m0s
[07:08:06.824] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:36:0)
[07:08:06.824] Timer tick, asking Buildbucket for the build status
[07:08:07.035] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:07.036] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:37:0) after 1m0s
[07:09:07.112] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:37:0)
[07:09:07.112] Timer tick, asking Buildbucket for the build status
[07:09:07.291] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:07.291] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:38:0) after 1m0s
[07:10:07.365] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:38:0)
[07:10:07.365] Timer tick, asking Buildbucket for the build status
[07:10:07.452] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:07.454] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:39:0) after 1m0s
[07:11:07.508] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:39:0)
[07:11:07.508] Timer tick, asking Buildbucket for the build status
[07:11:07.580] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:07.580] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:40:0) after 1m0s
[07:12:07.768] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:40:0)
[07:12:07.768] Timer tick, asking Buildbucket for the build status
[07:12:07.850] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:07.850] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:41:0) after 1m0s
[07:13:07.953] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:41:0)
[07:13:07.953] Timer tick, asking Buildbucket for the build status
[07:13:08.144] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:08.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:42:0) after 1m0s
[07:14:08.192] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:42:0)
[07:14:08.192] Timer tick, asking Buildbucket for the build status
[07:14:08.304] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:08.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:43:0) after 1m0s
[07:15:08.333] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:43:0)
[07:15:08.333] Timer tick, asking Buildbucket for the build status
[07:15:08.500] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:08.500] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:44:0) after 1m0s
[07:16:08.594] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:44:0)
[07:16:08.594] Timer tick, asking Buildbucket for the build status
[07:16:08.675] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:08.675] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:45:0) after 1m0s
[07:17:08.754] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:45:0)
[07:17:08.754] Timer tick, asking Buildbucket for the build status
[07:17:08.831] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:08.831] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:46:0) after 1m0s
[07:18:08.850] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:46:0)
[07:18:08.850] Timer tick, asking Buildbucket for the build status
[07:18:08.950] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:08.950] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:47:0) after 1m0s
[07:19:09.055] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:47:0)
[07:19:09.055] Timer tick, asking Buildbucket for the build status
[07:19:09.175] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:09.175] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:48:0) after 1m0s
[07:20:09.216] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:48:0)
[07:20:09.216] Timer tick, asking Buildbucket for the build status
[07:20:09.325] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:09.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:49:0) after 1m0s
[07:21:09.466] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:49:0)
[07:21:09.466] Timer tick, asking Buildbucket for the build status
[07:21:09.526] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:09.526] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:50:0) after 1m0s
[07:22:09.678] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:50:0)
[07:22:09.678] Timer tick, asking Buildbucket for the build status
[07:22:09.880] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:09.880] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:51:0) after 1m0s
[07:23:09.907] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:51:0)
[07:23:09.907] Timer tick, asking Buildbucket for the build status
[07:23:10.260] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:10.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:52:0) after 1m0s
[07:24:10.318] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:52:0)
[07:24:10.318] Timer tick, asking Buildbucket for the build status
[07:24:10.468] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:10.468] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:53:0) after 1m0s
[07:25:10.492] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:53:0)
[07:25:10.492] Timer tick, asking Buildbucket for the build status
[07:25:10.581] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:10.581] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:54:0) after 1m0s
[07:26:10.613] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:54:0)
[07:26:10.613] Timer tick, asking Buildbucket for the build status
[07:26:10.683] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:10.683] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:55:0) after 1m0s
[07:27:10.709] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:55:0)
[07:27:10.709] Timer tick, asking Buildbucket for the build status
[07:27:10.780] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:10.780] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:56:0) after 1m0s
[07:28:10.818] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:56:0)
[07:28:10.818] Timer tick, asking Buildbucket for the build status
[07:28:10.887] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:10.887] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:57:0) after 1m0s
[07:29:10.989] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:57:0)
[07:29:10.989] Timer tick, asking Buildbucket for the build status
[07:29:11.114] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:11.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:58:0) after 1m0s
[07:30:11.145] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:58:0)
[07:30:11.145] Timer tick, asking Buildbucket for the build status
[07:30:11.239] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:11.239] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:59:0) after 1m0s
[07:31:11.261] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:59:0)
[07:31:11.261] Timer tick, asking Buildbucket for the build status
[07:31:11.942] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:11.942] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:60:0) after 1m0s
[07:32:11.982] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:60:0)
[07:32:11.982] Timer tick, asking Buildbucket for the build status
[07:32:12.166] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:12.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:61:0) after 1m0s
[07:33:12.195] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:61:0)
[07:33:12.195] Timer tick, asking Buildbucket for the build status
[07:33:12.546] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:12.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:62:0) after 1m0s
[07:34:12.528] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:62:0)
[07:34:12.528] Timer tick, asking Buildbucket for the build status
[07:34:12.636] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:12.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:63:0) after 1m0s
[07:35:12.661] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:63:0)
[07:35:12.661] Timer tick, asking Buildbucket for the build status
[07:35:12.723] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:12.723] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:64:0) after 1m0s
[07:36:12.778] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:64:0)
[07:36:12.778] Timer tick, asking Buildbucket for the build status
[07:36:12.865] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:12.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:65:0) after 1m0s
[07:37:12.941] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:65:0)
[07:37:12.941] Timer tick, asking Buildbucket for the build status
[07:37:13.549] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:13.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:66:0) after 1m0s
[07:38:13.632] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:66:0)
[07:38:13.632] Timer tick, asking Buildbucket for the build status
[07:38:13.791] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:13.792] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:67:0) after 1m0s
[07:39:13.816] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:67:0)
[07:39:13.816] Timer tick, asking Buildbucket for the build status
[07:39:13.956] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:13.956] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:68:0) after 1m0s
[07:40:14.023] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:68:0)
[07:40:14.023] Timer tick, asking Buildbucket for the build status
[07:40:14.093] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:14.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:69:0) after 1m0s
[07:41:14.180] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:69:0)
[07:41:14.180] Timer tick, asking Buildbucket for the build status
[07:41:14.296] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:14.296] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:70:0) after 1m0s
[07:42:14.337] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:70:0)
[07:42:14.337] Timer tick, asking Buildbucket for the build status
[07:42:14.407] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:14.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:71:0) after 1m0s
[07:43:14.431] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:71:0)
[07:43:14.431] Timer tick, asking Buildbucket for the build status
[07:43:14.508] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:14.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:72:0) after 1m0s
[07:44:14.536] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:72:0)
[07:44:14.536] Timer tick, asking Buildbucket for the build status
[07:44:14.644] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:14.644] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:73:0) after 1m0s
[07:45:14.772] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:73:0)
[07:45:14.772] Timer tick, asking Buildbucket for the build status
[07:45:14.862] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:14.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:74:0) after 1m0s
[07:46:14.930] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:74:0)
[07:46:14.930] Timer tick, asking Buildbucket for the build status
[07:46:15.274] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:15.274] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:75:0) after 1m0s
[07:47:15.392] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:75:0)
[07:47:15.392] Timer tick, asking Buildbucket for the build status
[07:47:15.535] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:15.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:76:0) after 1m0s
[07:48:15.562] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:76:0)
[07:48:15.562] Timer tick, asking Buildbucket for the build status
[07:48:15.901] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:15.901] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:77:0) after 1m0s
[07:49:15.961] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:77:0)
[07:49:15.961] Timer tick, asking Buildbucket for the build status
[07:49:16.094] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:16.094] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:78:0) after 1m0s
[07:50:16.145] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:78:0)
[07:50:16.145] Timer tick, asking Buildbucket for the build status
[07:50:16.483] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:16.483] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:79:0) after 1m0s
[07:51:16.515] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:79:0)
[07:51:16.515] Timer tick, asking Buildbucket for the build status
[07:51:16.861] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:16.861] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:80:0) after 1m0s
[07:52:16.887] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:80:0)
[07:52:16.887] Timer tick, asking Buildbucket for the build status
[07:52:16.958] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:16.958] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:81:0) after 1m0s
[07:53:16.981] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:81:0)
[07:53:16.981] Timer tick, asking Buildbucket for the build status
[07:53:17.122] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:17.122] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:82:0) after 1m0s
[07:54:17.148] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:82:0)
[07:54:17.148] Timer tick, asking Buildbucket for the build status
[07:54:17.262] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:17.262] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:83:0) after 1m0s
[07:55:17.288] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:83:0)
[07:55:17.288] Timer tick, asking Buildbucket for the build status
[07:55:17.541] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:17.541] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:84:0) after 1m0s
[07:56:17.587] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:84:0)
[07:56:17.587] Timer tick, asking Buildbucket for the build status
[07:56:17.738] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:17.738] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:85:0) after 1m0s
[07:57:17.793] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:85:0)
[07:57:17.793] Timer tick, asking Buildbucket for the build status
[07:57:17.993] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:17.993] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:86:0) after 1m0s
[07:58:18.091] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:86:0)
[07:58:18.091] Timer tick, asking Buildbucket for the build status
[07:58:18.179] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:18.179] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:87:0) after 1m0s
[07:59:18.220] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:87:0)
[07:59:18.220] Timer tick, asking Buildbucket for the build status
[07:59:18.461] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:18.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:88:0) after 1m0s
[08:00:18.545] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:88:0)
[08:00:18.545] Timer tick, asking Buildbucket for the build status
[08:00:18.984] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:18.984] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:89:0) after 1m0s
[08:01:19.011] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:89:0)
[08:01:19.011] Timer tick, asking Buildbucket for the build status
[08:01:19.907] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:19.907] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:90:0) after 1m0s
[08:02:20.027] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:90:0)
[08:02:20.027] Timer tick, asking Buildbucket for the build status
[08:02:20.115] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:20.115] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:91:0) after 1m0s
[08:03:20.144] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:91:0)
[08:03:20.144] Timer tick, asking Buildbucket for the build status
[08:03:20.231] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:20.232] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:92:0) after 1m0s
[08:04:20.319] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:92:0)
[08:04:20.319] Timer tick, asking Buildbucket for the build status
[08:04:20.825] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:20.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:93:0) after 1m0s
[08:05:20.816] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:93:0)
[08:05:20.816] Timer tick, asking Buildbucket for the build status
[08:05:20.886] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:20.887] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:94:0) after 1m0s
[08:06:20.916] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:94:0)
[08:06:20.916] Timer tick, asking Buildbucket for the build status
[08:06:20.987] Build 8864764460954313712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:20.987] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9030194523631713168:95:0) after 1m0s
[08:06:28.039] Received PubSub notification, asking Buildbucket for the build status
[08:06:28.262] Build 8864764460954313712: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:06:28.262] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1604304387249473",
"created_by": "project:fuchsia",
"created_ts": "1604298834804808",
"id": "8864764460954313712",
"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\": \"b1a92c635c1ec10fd703302ce1fc4ab3a8515a04\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@b1a92c635c1ec10fd703302ce1fc4ab3a8515a04\", \"title\": \"b1a92c635c1ec10fd703302ce1fc4ab3a8515a04\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/b1a92c635c1ec10fd703302ce1fc4ab3a8515a04\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"8807d3127cb4b9199a3d5a16aa2851cc28e9826c\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@8807d3127cb4b9199a3d5a16aa2851cc28e9826c\", \"title\": \"8807d3127cb4b9199a3d5a16aa2851cc28e9826c\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/8807d3127cb4b9199a3d5a16aa2851cc28e9826c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"8807d3127cb4b9199a3d5a16aa2851cc28e9826c\"}}",
"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-1-btev\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1604298836071776",
"status": "COMPLETED",
"status_changed_ts": "1604304387743047",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/8807d3127cb4b9199a3d5a16aa2851cc28e9826c",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/8807d3127cb4b9199a3d5a16aa2851cc28e9826c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030194523631713168",
"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/8864764460954313712/+/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:4fa07b0f03728a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604304387803414",
"url": "https://ci.chromium.org/b/8864764460954313712",
"utcnow_ts": "1604304388245135"
}
}
[08:06:28.262] Invocation finished in 1h32m35.393806667s with status SUCCEEDED