[06:34:10.942] New invocation is queued and will start shortly
[06:34:12.084] Starting the invocation (attempt 1)
[06:34:12.135] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:34:12.135] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:34:12.135] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9036536292347516960",
"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\":\"d04aee0f41da38682239b57af954bf294e26d9cb\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@d04aee0f41da38682239b57af954bf294e26d9cb\",\"title\":\"d04aee0f41da38682239b57af954bf294e26d9cb\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/d04aee0f41da38682239b57af954bf294e26d9cb\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"85d14aaeb757550d63254fae5c0415b782e59a29\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@85d14aaeb757550d63254fae5c0415b782e59a29\",\"title\":\"85d14aaeb757550d63254fae5c0415b782e59a29\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/85d14aaeb757550d63254fae5c0415b782e59a29\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"f3da8a96ee360c98a94b47835e8f238e61cf5f11\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f3da8a96ee360c98a94b47835e8f238e61cf5f11\",\"title\":\"f3da8a96ee360c98a94b47835e8f238e61cf5f11\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/f3da8a96ee360c98a94b47835e8f238e61cf5f11\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"f16c3d4f137ae02fab0982782b2e1c2b2afc8583\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f16c3d4f137ae02fab0982782b2e1c2b2afc8583\",\"title\":\"f16c3d4f137ae02fab0982782b2e1c2b2afc8583\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/f16c3d4f137ae02fab0982782b2e1c2b2afc8583\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"f16c3d4f137ae02fab0982782b2e1c2b2afc8583\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-prod-trigger",
"scheduler_invocation_id:9036536292347516960",
"scheduler_job_id:fuchsia/gcc-prod-trigger-3e002780",
"user_agent:luci-scheduler",
"buildset:commit/git/f16c3d4f137ae02fab0982782b2e1c2b2afc8583",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/f16c3d4f137ae02fab0982782b2e1c2b2afc8583",
"gitiles_ref:refs/heads/master"
]
}
[06:34:13.430] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1598250852320092",
"id": "8871106230235952976",
"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\": \"d04aee0f41da38682239b57af954bf294e26d9cb\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@d04aee0f41da38682239b57af954bf294e26d9cb\", \"title\": \"d04aee0f41da38682239b57af954bf294e26d9cb\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/d04aee0f41da38682239b57af954bf294e26d9cb\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"85d14aaeb757550d63254fae5c0415b782e59a29\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@85d14aaeb757550d63254fae5c0415b782e59a29\", \"title\": \"85d14aaeb757550d63254fae5c0415b782e59a29\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/85d14aaeb757550d63254fae5c0415b782e59a29\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"f3da8a96ee360c98a94b47835e8f238e61cf5f11\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f3da8a96ee360c98a94b47835e8f238e61cf5f11\", \"title\": \"f3da8a96ee360c98a94b47835e8f238e61cf5f11\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/f3da8a96ee360c98a94b47835e8f238e61cf5f11\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"f16c3d4f137ae02fab0982782b2e1c2b2afc8583\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f16c3d4f137ae02fab0982782b2e1c2b2afc8583\", \"title\": \"f16c3d4f137ae02fab0982782b2e1c2b2afc8583\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/f16c3d4f137ae02fab0982782b2e1c2b2afc8583\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"f16c3d4f137ae02fab0982782b2e1c2b2afc8583\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1598250853105817",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/f16c3d4f137ae02fab0982782b2e1c2b2afc8583",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/f16c3d4f137ae02fab0982782b2e1c2b2afc8583",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036536292347516960",
"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/8871106230235952976/+/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": "1598250853105970",
"url": "https://ci.chromium.org/b/8871106230235952976",
"utcnow_ts": "1598250853407913"
}
}
[06:34:13.430] Task URL: https://ci.chromium.org/b/8871106230235952976
[06:34:13.430] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:2:0) after 1m0s
[06:34:48.130] Received PubSub notification, asking Buildbucket for the build status
[06:34:48.611] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:13.565] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:2:0)
[06:35:13.565] Timer tick, asking Buildbucket for the build status
[06:35:13.767] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:13.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:4:0) after 1m0s
[06:36:13.790] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:4:0)
[06:36:13.790] Timer tick, asking Buildbucket for the build status
[06:36:14.070] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:14.070] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:5:0) after 1m0s
[06:37:14.211] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:5:0)
[06:37:14.212] Timer tick, asking Buildbucket for the build status
[06:37:14.327] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:14.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:6:0) after 1m0s
[06:38:14.393] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:6:0)
[06:38:14.393] Timer tick, asking Buildbucket for the build status
[06:38:15.645] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:15.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:7:0) after 1m0s
[06:39:16.064] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:7:0)
[06:39:16.064] Timer tick, asking Buildbucket for the build status
[06:39:16.518] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:16.518] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:8:0) after 1m0s
[06:40:16.762] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:8:0)
[06:40:16.762] Timer tick, asking Buildbucket for the build status
[06:40:16.878] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:16.878] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:9:0) after 1m0s
[06:41:17.195] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:9:0)
[06:41:17.195] Timer tick, asking Buildbucket for the build status
[06:41:17.336] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:17.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:10:0) after 1m0s
[06:42:17.353] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:10:0)
[06:42:17.353] Timer tick, asking Buildbucket for the build status
[06:42:17.440] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:17.440] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:11:0) after 1m0s
[06:43:17.726] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:11:0)
[06:43:17.726] Timer tick, asking Buildbucket for the build status
[06:43:17.820] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:17.820] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:12:0) after 1m0s
[06:44:17.985] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:12:0)
[06:44:17.985] Timer tick, asking Buildbucket for the build status
[06:44:18.191] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:18.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:13:0) after 1m0s
[06:45:18.213] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:13:0)
[06:45:18.213] Timer tick, asking Buildbucket for the build status
[06:45:18.339] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:18.339] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:14:0) after 1m0s
[06:46:18.441] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:14:0)
[06:46:18.441] Timer tick, asking Buildbucket for the build status
[06:46:18.527] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:18.527] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:15:0) after 1m0s
[06:47:18.664] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:15:0)
[06:47:18.664] Timer tick, asking Buildbucket for the build status
[06:47:18.767] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:18.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:16:0) after 1m0s
[06:48:18.783] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:16:0)
[06:48:18.783] Timer tick, asking Buildbucket for the build status
[06:48:18.996] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:18.996] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:17:0) after 1m0s
[06:49:19.185] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:17:0)
[06:49:19.185] Timer tick, asking Buildbucket for the build status
[06:49:19.373] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:19.373] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:18:0) after 1m0s
[06:50:19.574] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:18:0)
[06:50:19.574] Timer tick, asking Buildbucket for the build status
[06:50:20.692] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:20.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:19:0) after 1m0s
[06:51:20.690] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:19:0)
[06:51:20.690] Timer tick, asking Buildbucket for the build status
[06:51:20.856] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:20.856] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:20:0) after 1m0s
[06:52:20.882] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:20:0)
[06:52:20.882] Timer tick, asking Buildbucket for the build status
[06:52:20.946] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:20.946] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:21:0) after 1m0s
[06:53:20.971] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:21:0)
[06:53:20.971] Timer tick, asking Buildbucket for the build status
[06:53:21.131] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:21.131] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:22:0) after 1m0s
[06:54:21.187] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:22:0)
[06:54:21.187] Timer tick, asking Buildbucket for the build status
[06:54:22.530] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:22.530] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:23:0) after 1m0s
[06:55:22.516] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:23:0)
[06:55:22.516] Timer tick, asking Buildbucket for the build status
[06:55:22.628] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:22.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:24:0) after 1m0s
[06:56:22.653] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:24:0)
[06:56:22.653] Timer tick, asking Buildbucket for the build status
[06:56:22.753] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:22.753] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:25:0) after 1m0s
[06:57:22.767] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:25:0)
[06:57:22.767] Timer tick, asking Buildbucket for the build status
[06:57:22.844] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:22.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:26:0) after 1m0s
[06:58:22.922] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:26:0)
[06:58:22.922] Timer tick, asking Buildbucket for the build status
[06:58:23.264] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:23.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:27:0) after 1m0s
[06:59:23.325] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:27:0)
[06:59:23.325] Timer tick, asking Buildbucket for the build status
[06:59:23.532] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:23.532] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:28:0) after 1m0s
[07:00:23.589] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:28:0)
[07:00:23.590] Timer tick, asking Buildbucket for the build status
[07:00:24.544] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:24.544] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:29:0) after 1m0s
[07:01:24.600] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:29:0)
[07:01:24.600] Timer tick, asking Buildbucket for the build status
[07:01:24.722] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:24.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:30:0) after 1m0s
[07:02:24.783] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:30:0)
[07:02:24.783] Timer tick, asking Buildbucket for the build status
[07:02:25.203] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:25.203] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:31:0) after 1m0s
[07:03:25.253] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:31:0)
[07:03:25.253] Timer tick, asking Buildbucket for the build status
[07:03:25.400] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:25.400] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:32:0) after 1m0s
[07:04:25.434] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:32:0)
[07:04:25.434] Timer tick, asking Buildbucket for the build status
[07:04:25.616] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:25.616] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:33:0) after 1m0s
[07:05:25.703] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:33:0)
[07:05:25.703] Timer tick, asking Buildbucket for the build status
[07:05:25.994] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:25.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:34:0) after 1m0s
[07:06:26.002] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:34:0)
[07:06:26.002] Timer tick, asking Buildbucket for the build status
[07:06:26.122] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:26.122] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:35:0) after 1m0s
[07:07:26.154] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:35:0)
[07:07:26.154] Timer tick, asking Buildbucket for the build status
[07:07:26.323] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:26.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:36:0) after 1m0s
[07:08:26.347] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:36:0)
[07:08:26.348] Timer tick, asking Buildbucket for the build status
[07:08:26.465] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:26.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:37:0) after 1m0s
[07:09:26.572] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:37:0)
[07:09:26.572] Timer tick, asking Buildbucket for the build status
[07:09:26.807] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:26.807] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:38:0) after 1m0s
[07:10:26.851] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:38:0)
[07:10:26.851] Timer tick, asking Buildbucket for the build status
[07:10:28.536] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:28.536] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:39:0) after 1m0s
[07:11:28.572] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:39:0)
[07:11:28.572] Timer tick, asking Buildbucket for the build status
[07:11:28.676] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:28.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:40:0) after 1m0s
[07:12:28.726] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:40:0)
[07:12:28.726] Timer tick, asking Buildbucket for the build status
[07:12:29.074] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:29.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:41:0) after 1m0s
[07:13:29.169] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:41:0)
[07:13:29.169] Timer tick, asking Buildbucket for the build status
[07:13:29.361] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:29.361] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:42:0) after 1m0s
[07:14:29.420] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:42:0)
[07:14:29.420] Timer tick, asking Buildbucket for the build status
[07:14:29.583] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:29.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:43:0) after 1m0s
[07:15:29.610] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:43:0)
[07:15:29.610] Timer tick, asking Buildbucket for the build status
[07:15:30.018] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:30.018] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:44:0) after 1m0s
[07:16:30.090] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:44:0)
[07:16:30.090] Timer tick, asking Buildbucket for the build status
[07:16:30.253] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:30.253] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:45:0) after 1m0s
[07:17:30.242] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:45:0)
[07:17:30.242] Timer tick, asking Buildbucket for the build status
[07:17:30.367] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:30.367] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:46:0) after 1m0s
[07:18:32.639] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:46:0)
[07:18:32.639] Timer tick, asking Buildbucket for the build status
[07:18:32.895] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:32.895] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:47:0) after 1m0s
[07:19:32.997] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:47:0)
[07:19:32.997] Timer tick, asking Buildbucket for the build status
[07:19:33.509] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:33.509] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:48:0) after 1m0s
[07:20:33.633] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:48:0)
[07:20:33.633] Timer tick, asking Buildbucket for the build status
[07:20:33.839] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:33.839] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:49:0) after 1m0s
[07:21:33.943] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:49:0)
[07:21:33.943] Timer tick, asking Buildbucket for the build status
[07:21:34.100] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:34.100] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:50:0) after 1m0s
[07:22:34.143] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:50:0)
[07:22:34.143] Timer tick, asking Buildbucket for the build status
[07:22:34.367] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:34.367] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:51:0) after 1m0s
[07:23:34.550] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:51:0)
[07:23:34.550] Timer tick, asking Buildbucket for the build status
[07:23:34.883] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:34.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:52:0) after 1m0s
[07:24:35.326] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:52:0)
[07:24:35.326] Timer tick, asking Buildbucket for the build status
[07:24:36.650] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:36.650] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:53:0) after 1m0s
[07:25:36.679] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:53:0)
[07:25:36.679] Timer tick, asking Buildbucket for the build status
[07:25:36.912] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:36.912] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:54:0) after 1m0s
[07:26:37.013] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:54:0)
[07:26:37.013] Timer tick, asking Buildbucket for the build status
[07:26:37.157] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:37.157] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:55:0) after 1m0s
[07:27:37.181] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:55:0)
[07:27:37.181] Timer tick, asking Buildbucket for the build status
[07:27:37.354] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:37.354] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:56:0) after 1m0s
[07:28:37.342] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:56:0)
[07:28:37.343] Timer tick, asking Buildbucket for the build status
[07:28:37.435] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:37.435] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:57:0) after 1m0s
[07:29:37.471] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:57:0)
[07:29:37.471] Timer tick, asking Buildbucket for the build status
[07:29:37.635] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:37.635] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:58:0) after 1m0s
[07:30:37.651] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:58:0)
[07:30:37.651] Timer tick, asking Buildbucket for the build status
[07:30:38.747] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:38.747] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:59:0) after 1m0s
[07:31:38.862] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:59:0)
[07:31:38.862] Timer tick, asking Buildbucket for the build status
[07:31:39.034] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:39.034] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:60:0) after 1m0s
[07:32:39.067] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:60:0)
[07:32:39.067] Timer tick, asking Buildbucket for the build status
[07:32:39.195] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:39.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:61:0) after 1m0s
[07:33:39.219] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:61:0)
[07:33:39.219] Timer tick, asking Buildbucket for the build status
[07:33:39.585] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:39.585] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:62:0) after 1m0s
[07:34:39.628] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:62:0)
[07:34:39.628] Timer tick, asking Buildbucket for the build status
[07:34:40.165] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:40.165] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:63:0) after 1m0s
[07:35:40.264] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:63:0)
[07:35:40.264] Timer tick, asking Buildbucket for the build status
[07:35:40.399] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:40.399] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:64:0) after 1m0s
[07:36:40.411] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:64:0)
[07:36:40.411] Timer tick, asking Buildbucket for the build status
[07:36:41.073] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:41.073] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:65:0) after 1m0s
[07:37:41.175] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:65:0)
[07:37:41.175] Timer tick, asking Buildbucket for the build status
[07:37:41.440] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:41.440] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:66:0) after 1m0s
[07:38:41.481] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:66:0)
[07:38:41.481] Timer tick, asking Buildbucket for the build status
[07:38:41.601] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:41.601] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:67:0) after 1m0s
[07:39:41.632] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:67:0)
[07:39:41.632] Timer tick, asking Buildbucket for the build status
[07:39:43.314] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:43.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:68:0) after 1m0s
[07:40:43.316] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:68:0)
[07:40:43.316] Timer tick, asking Buildbucket for the build status
[07:40:44.025] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:44.025] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:69:0) after 1m0s
[07:41:44.051] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:69:0)
[07:41:44.051] Timer tick, asking Buildbucket for the build status
[07:41:44.126] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:44.126] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:70:0) after 1m0s
[07:42:44.251] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:70:0)
[07:42:44.251] Timer tick, asking Buildbucket for the build status
[07:42:44.383] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:44.383] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:71:0) after 1m0s
[07:43:44.522] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:71:0)
[07:43:44.522] Timer tick, asking Buildbucket for the build status
[07:43:44.662] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:44.662] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:72:0) after 1m0s
[07:44:44.749] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:72:0)
[07:44:44.749] Timer tick, asking Buildbucket for the build status
[07:44:47.165] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:47.165] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:73:0) after 1m0s
[07:45:47.187] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:73:0)
[07:45:47.187] Timer tick, asking Buildbucket for the build status
[07:45:47.365] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:47.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:74:0) after 1m0s
[07:46:47.403] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:74:0)
[07:46:47.403] Timer tick, asking Buildbucket for the build status
[07:46:47.553] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:47.553] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:75:0) after 1m0s
[07:47:47.680] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:75:0)
[07:47:47.680] Timer tick, asking Buildbucket for the build status
[07:47:47.804] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:47.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:76:0) after 1m0s
[07:48:47.894] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:76:0)
[07:48:47.894] Timer tick, asking Buildbucket for the build status
[07:48:48.005] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:48.005] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:77:0) after 1m0s
[07:49:48.091] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:77:0)
[07:49:48.091] Timer tick, asking Buildbucket for the build status
[07:49:52.982] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:52.982] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:78:0) after 1m0s
[07:50:52.973] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:78:0)
[07:50:52.973] Timer tick, asking Buildbucket for the build status
[07:50:53.162] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:53.162] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:79:0) after 1m0s
[07:51:53.193] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:79:0)
[07:51:53.193] Timer tick, asking Buildbucket for the build status
[07:51:53.301] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:53.301] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:80:0) after 1m0s
[07:52:53.324] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:80:0)
[07:52:53.325] Timer tick, asking Buildbucket for the build status
[07:52:53.713] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:53.713] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:81:0) after 1m0s
[07:53:53.733] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:81:0)
[07:53:53.733] Timer tick, asking Buildbucket for the build status
[07:53:53.910] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:53.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:82:0) after 1m0s
[07:54:53.945] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:82:0)
[07:54:53.945] Timer tick, asking Buildbucket for the build status
[07:54:54.989] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:54.989] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:83:0) after 1m0s
[07:55:55.025] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:83:0)
[07:55:55.025] Timer tick, asking Buildbucket for the build status
[07:55:55.096] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:55.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:84:0) after 1m0s
[07:56:55.160] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:84:0)
[07:56:55.160] Timer tick, asking Buildbucket for the build status
[07:56:55.309] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:55.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:85:0) after 1m0s
[07:57:55.339] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:85:0)
[07:57:55.339] Timer tick, asking Buildbucket for the build status
[07:57:55.597] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:55.597] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:86:0) after 1m0s
[07:58:55.633] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:86:0)
[07:58:55.633] Timer tick, asking Buildbucket for the build status
[07:58:56.093] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:56.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:87:0) after 1m0s
[07:59:56.118] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:87:0)
[07:59:56.118] Timer tick, asking Buildbucket for the build status
[07:59:56.444] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:56.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:88:0) after 1m0s
[08:00:56.467] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:88:0)
[08:00:56.467] Timer tick, asking Buildbucket for the build status
[08:00:56.616] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:56.616] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:89:0) after 1m0s
[08:01:56.689] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:89:0)
[08:01:56.689] Timer tick, asking Buildbucket for the build status
[08:01:56.991] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:56.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:90:0) after 1m0s
[08:02:57.034] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:90:0)
[08:02:57.034] Timer tick, asking Buildbucket for the build status
[08:02:57.195] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:57.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:91:0) after 1m0s
[08:03:57.221] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:91:0)
[08:03:57.221] Timer tick, asking Buildbucket for the build status
[08:03:57.527] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:57.527] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:92:0) after 1m0s
[08:04:57.574] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:92:0)
[08:04:57.574] Timer tick, asking Buildbucket for the build status
[08:04:57.916] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:57.916] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:93:0) after 1m0s
[08:05:57.955] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:93:0)
[08:05:57.955] Timer tick, asking Buildbucket for the build status
[08:05:58.053] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:58.054] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:94:0) after 1m0s
[08:06:58.133] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:94:0)
[08:06:58.133] Timer tick, asking Buildbucket for the build status
[08:06:58.674] Build 8871106230235952976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:58.674] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9036536292347516960:95:0) after 1m0s
[08:07:18.323] Received PubSub notification, asking Buildbucket for the build status
[08:07:18.461] Build 8871106230235952976: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:07:18.461] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1598256436056889",
"created_by": "project:fuchsia",
"created_ts": "1598250852320092",
"id": "8871106230235952976",
"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\": \"d04aee0f41da38682239b57af954bf294e26d9cb\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@d04aee0f41da38682239b57af954bf294e26d9cb\", \"title\": \"d04aee0f41da38682239b57af954bf294e26d9cb\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/d04aee0f41da38682239b57af954bf294e26d9cb\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"85d14aaeb757550d63254fae5c0415b782e59a29\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@85d14aaeb757550d63254fae5c0415b782e59a29\", \"title\": \"85d14aaeb757550d63254fae5c0415b782e59a29\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/85d14aaeb757550d63254fae5c0415b782e59a29\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"f3da8a96ee360c98a94b47835e8f238e61cf5f11\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f3da8a96ee360c98a94b47835e8f238e61cf5f11\", \"title\": \"f3da8a96ee360c98a94b47835e8f238e61cf5f11\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/f3da8a96ee360c98a94b47835e8f238e61cf5f11\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"f16c3d4f137ae02fab0982782b2e1c2b2afc8583\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f16c3d4f137ae02fab0982782b2e1c2b2afc8583\", \"title\": \"f16c3d4f137ae02fab0982782b2e1c2b2afc8583\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/f16c3d4f137ae02fab0982782b2e1c2b2afc8583\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"f16c3d4f137ae02fab0982782b2e1c2b2afc8583\"}}",
"project": "fuchsia",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"d04aee0f41da38682239b57af954bf294e26d9cb\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@d04aee0f41da38682239b57af954bf294e26d9cb\", \"title\": \"d04aee0f41da38682239b57af954bf294e26d9cb\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/d04aee0f41da38682239b57af954bf294e26d9cb\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"85d14aaeb757550d63254fae5c0415b782e59a29\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@85d14aaeb757550d63254fae5c0415b782e59a29\", \"title\": \"85d14aaeb757550d63254fae5c0415b782e59a29\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/85d14aaeb757550d63254fae5c0415b782e59a29\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"f3da8a96ee360c98a94b47835e8f238e61cf5f11\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f3da8a96ee360c98a94b47835e8f238e61cf5f11\", \"title\": \"f3da8a96ee360c98a94b47835e8f238e61cf5f11\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/f3da8a96ee360c98a94b47835e8f238e61cf5f11\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"f16c3d4f137ae02fab0982782b2e1c2b2afc8583\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f16c3d4f137ae02fab0982782b2e1c2b2afc8583\", \"title\": \"f16c3d4f137ae02fab0982782b2e1c2b2afc8583\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/f16c3d4f137ae02fab0982782b2e1c2b2afc8583\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"fuchsia-prod-e2-2-ssd0-us-central1-f-0-zafc\", \"branch\": \"refs/heads/master\", \"bucket\": \"prod\", \"buildername\": \"gcc-prod-trigger\", \"builders\": [\"gcc-arm64-linux\", \"gcc-x64-linux\", \"gcc-x64-mac\"], \"enforce_output\": true, \"mastername\": \"gcc\", \"path_config\": \"generic\", \"recipe\": \"toolchain_trigger\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"f16c3d4f137ae02fab0982782b2e1c2b2afc8583\", \"timeout\": 7200.0, \"triggers\": [\"gcc-goma\"]}, \"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-f-0-zafc\"], \"image\": [\"fuchsia-debian-9-drawfork-v20200619-813ca9d23e\"], \"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\"], \"scale_group\": [\"fuchsia-prod-e2-2-ssd0\"], \"server_version\": [\"5498-3454aa6\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-f\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1598250887230523",
"status": "COMPLETED",
"status_changed_ts": "1598256437115500",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/f16c3d4f137ae02fab0982782b2e1c2b2afc8583",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/f16c3d4f137ae02fab0982782b2e1c2b2afc8583",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036536292347516960",
"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/8871106230235952976/+/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:4e37fe2ce75bee10",
"user_agent:luci-scheduler"
],
"updated_ts": "1598256437791647",
"url": "https://ci.chromium.org/b/8871106230235952976",
"utcnow_ts": "1598256438450787"
}
}
[08:07:18.461] Invocation finished in 1h33m7.538273325s with status SUCCEEDED