[18:34:04.926] New invocation is queued and will start shortly
[18:34:06.072] Starting the invocation (attempt 1)
[18:34:06.108] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:34:06.111] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:34:06.111] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9023354440043530496",
"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\":\"75a933f39918ce4f4b9481234992895e022787ee\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@75a933f39918ce4f4b9481234992895e022787ee\",\"title\":\"75a933f39918ce4f4b9481234992895e022787ee\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/75a933f39918ce4f4b9481234992895e022787ee\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"75a933f39918ce4f4b9481234992895e022787ee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-prod-trigger",
"scheduler_invocation_id:9023354440043530496",
"scheduler_job_id:fuchsia/gcc-prod-trigger-3e002780",
"user_agent:luci-scheduler",
"buildset:commit/git/75a933f39918ce4f4b9481234992895e022787ee",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/75a933f39918ce4f4b9481234992895e022787ee",
"gitiles_ref:refs/heads/master"
]
}
[18:34:06.631] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1610822046201245",
"id": "8857924378040509712",
"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\": \"75a933f39918ce4f4b9481234992895e022787ee\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@75a933f39918ce4f4b9481234992895e022787ee\", \"title\": \"75a933f39918ce4f4b9481234992895e022787ee\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/75a933f39918ce4f4b9481234992895e022787ee\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"75a933f39918ce4f4b9481234992895e022787ee\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610822046483280",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/75a933f39918ce4f4b9481234992895e022787ee",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/75a933f39918ce4f4b9481234992895e022787ee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023354440043530496",
"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/8857924378040509712/+/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": "1610822046483402",
"url": "https://ci.chromium.org/b/8857924378040509712",
"utcnow_ts": "1610822046624649"
}
}
[18:34:06.631] Task URL: https://ci.chromium.org/b/8857924378040509712
[18:34:06.631] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:2:0) after 1m0s
[18:34:18.537] Received PubSub notification, asking Buildbucket for the build status
[18:34:18.613] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:06.749] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:2:0)
[18:35:06.749] Timer tick, asking Buildbucket for the build status
[18:35:06.884] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:06.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:4:0) after 1m0s
[18:36:06.904] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:4:0)
[18:36:06.904] Timer tick, asking Buildbucket for the build status
[18:36:07.085] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:07.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:5:0) after 1m0s
[18:37:07.093] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:5:0)
[18:37:07.093] Timer tick, asking Buildbucket for the build status
[18:37:07.176] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:07.176] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:6:0) after 1m0s
[18:38:07.199] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:6:0)
[18:38:07.199] Timer tick, asking Buildbucket for the build status
[18:38:07.265] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:07.265] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:7:0) after 1m0s
[18:39:07.283] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:7:0)
[18:39:07.283] Timer tick, asking Buildbucket for the build status
[18:39:07.352] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:07.352] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:8:0) after 1m0s
[18:40:07.372] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:8:0)
[18:40:07.372] Timer tick, asking Buildbucket for the build status
[18:40:07.496] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:07.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:9:0) after 1m0s
[18:41:07.516] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:9:0)
[18:41:07.516] Timer tick, asking Buildbucket for the build status
[18:41:07.724] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:07.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:10:0) after 1m0s
[18:42:07.751] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:10:0)
[18:42:07.751] Timer tick, asking Buildbucket for the build status
[18:42:07.923] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:07.923] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:11:0) after 1m0s
[18:43:07.949] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:11:0)
[18:43:07.949] Timer tick, asking Buildbucket for the build status
[18:43:08.014] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:08.014] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:12:0) after 1m0s
[18:44:08.034] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:12:0)
[18:44:08.034] Timer tick, asking Buildbucket for the build status
[18:44:08.121] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:08.121] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:13:0) after 1m0s
[18:45:08.151] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:13:0)
[18:45:08.151] Timer tick, asking Buildbucket for the build status
[18:45:08.251] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:08.251] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:14:0) after 1m0s
[18:46:08.372] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:14:0)
[18:46:08.372] Timer tick, asking Buildbucket for the build status
[18:46:08.721] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:08.721] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:15:0) after 1m0s
[18:47:08.771] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:15:0)
[18:47:08.771] Timer tick, asking Buildbucket for the build status
[18:47:09.011] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:09.011] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:16:0) after 1m0s
[18:48:09.081] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:16:0)
[18:48:09.081] Timer tick, asking Buildbucket for the build status
[18:48:09.649] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:09.649] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:17:0) after 1m0s
[18:49:09.669] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:17:0)
[18:49:09.669] Timer tick, asking Buildbucket for the build status
[18:49:09.836] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:09.836] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:18:0) after 1m0s
[18:50:09.871] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:18:0)
[18:50:09.871] Timer tick, asking Buildbucket for the build status
[18:50:09.978] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:09.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:19:0) after 1m0s
[18:51:10.022] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:19:0)
[18:51:10.022] Timer tick, asking Buildbucket for the build status
[18:51:10.093] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:10.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:20:0) after 1m0s
[18:52:10.112] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:20:0)
[18:52:10.112] Timer tick, asking Buildbucket for the build status
[18:52:10.341] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:10.341] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:21:0) after 1m0s
[18:53:10.395] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:21:0)
[18:53:10.395] Timer tick, asking Buildbucket for the build status
[18:53:10.542] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:10.542] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:22:0) after 1m0s
[18:54:10.634] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:22:0)
[18:54:10.634] Timer tick, asking Buildbucket for the build status
[18:54:10.739] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:10.739] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:23:0) after 1m0s
[18:55:10.788] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:23:0)
[18:55:10.788] Timer tick, asking Buildbucket for the build status
[18:55:10.996] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:10.996] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:24:0) after 1m0s
[18:56:11.019] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:24:0)
[18:56:11.020] Timer tick, asking Buildbucket for the build status
[18:56:11.353] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:11.353] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:25:0) after 1m0s
[18:57:11.419] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:25:0)
[18:57:11.419] Timer tick, asking Buildbucket for the build status
[18:57:11.514] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:11.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:26:0) after 1m0s
[18:58:11.619] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:26:0)
[18:58:11.619] Timer tick, asking Buildbucket for the build status
[18:58:11.685] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:11.685] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:27:0) after 1m0s
[18:59:11.709] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:27:0)
[18:59:11.709] Timer tick, asking Buildbucket for the build status
[18:59:11.810] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:11.810] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:28:0) after 1m0s
[19:00:11.834] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:28:0)
[19:00:11.834] Timer tick, asking Buildbucket for the build status
[19:00:12.085] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:12.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:29:0) after 1m0s
[19:01:12.141] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:29:0)
[19:01:12.141] Timer tick, asking Buildbucket for the build status
[19:01:12.335] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:12.335] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:30:0) after 1m0s
[19:02:12.357] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:30:0)
[19:02:12.357] Timer tick, asking Buildbucket for the build status
[19:02:12.505] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:12.505] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:31:0) after 1m0s
[19:03:12.531] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:31:0)
[19:03:12.531] Timer tick, asking Buildbucket for the build status
[19:03:12.601] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:12.601] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:32:0) after 1m0s
[19:04:12.624] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:32:0)
[19:04:12.624] Timer tick, asking Buildbucket for the build status
[19:04:12.785] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:12.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:33:0) after 1m0s
[19:05:12.839] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:33:0)
[19:05:12.839] Timer tick, asking Buildbucket for the build status
[19:05:12.994] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:12.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:34:0) after 1m0s
[19:06:13.015] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:34:0)
[19:06:13.015] Timer tick, asking Buildbucket for the build status
[19:06:13.095] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:13.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:35:0) after 1m0s
[19:07:13.117] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:35:0)
[19:07:13.117] Timer tick, asking Buildbucket for the build status
[19:07:13.558] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:13.558] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:36:0) after 1m0s
[19:08:13.631] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:36:0)
[19:08:13.631] Timer tick, asking Buildbucket for the build status
[19:08:13.693] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:13.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:37:0) after 1m0s
[19:09:13.731] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:37:0)
[19:09:13.731] Timer tick, asking Buildbucket for the build status
[19:09:13.914] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:13.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:38:0) after 1m0s
[19:10:13.978] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:38:0)
[19:10:13.978] Timer tick, asking Buildbucket for the build status
[19:10:14.063] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:14.063] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:39:0) after 1m0s
[19:11:14.192] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:39:0)
[19:11:14.192] Timer tick, asking Buildbucket for the build status
[19:11:14.347] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:14.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:40:0) after 1m0s
[19:12:14.329] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:40:0)
[19:12:14.329] Timer tick, asking Buildbucket for the build status
[19:12:14.594] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:14.594] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:41:0) after 1m0s
[19:13:14.658] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:41:0)
[19:13:14.658] Timer tick, asking Buildbucket for the build status
[19:13:14.804] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:14.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:42:0) after 1m0s
[19:14:14.862] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:42:0)
[19:14:14.862] Timer tick, asking Buildbucket for the build status
[19:14:16.097] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:16.097] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:43:0) after 1m0s
[19:15:16.117] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:43:0)
[19:15:16.117] Timer tick, asking Buildbucket for the build status
[19:15:16.178] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:16.178] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:44:0) after 1m0s
[19:16:16.240] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:44:0)
[19:16:16.240] Timer tick, asking Buildbucket for the build status
[19:16:16.546] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:16.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:45:0) after 1m0s
[19:17:16.567] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:45:0)
[19:17:16.567] Timer tick, asking Buildbucket for the build status
[19:17:16.626] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:16.626] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:46:0) after 1m0s
[19:18:16.614] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:46:0)
[19:18:16.614] Timer tick, asking Buildbucket for the build status
[19:18:16.823] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:16.824] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:47:0) after 1m0s
[19:19:16.876] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:47:0)
[19:19:16.876] Timer tick, asking Buildbucket for the build status
[19:19:16.983] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:16.983] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:48:0) after 1m0s
[19:20:17.013] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:48:0)
[19:20:17.013] Timer tick, asking Buildbucket for the build status
[19:20:17.122] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:17.122] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:49:0) after 1m0s
[19:21:17.140] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:49:0)
[19:21:17.140] Timer tick, asking Buildbucket for the build status
[19:21:17.424] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:17.424] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:50:0) after 1m0s
[19:22:17.442] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:50:0)
[19:22:17.442] Timer tick, asking Buildbucket for the build status
[19:22:17.582] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:17.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:51:0) after 1m0s
[19:23:17.651] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:51:0)
[19:23:17.651] Timer tick, asking Buildbucket for the build status
[19:23:17.756] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:17.756] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:52:0) after 1m0s
[19:24:17.775] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:52:0)
[19:24:17.775] Timer tick, asking Buildbucket for the build status
[19:24:17.978] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:17.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:53:0) after 1m0s
[19:25:17.996] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:53:0)
[19:25:17.996] Timer tick, asking Buildbucket for the build status
[19:25:18.067] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:18.067] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:54:0) after 1m0s
[19:26:18.086] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:54:0)
[19:26:18.086] Timer tick, asking Buildbucket for the build status
[19:26:18.294] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:18.294] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:55:0) after 1m0s
[19:27:18.315] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:55:0)
[19:27:18.315] Timer tick, asking Buildbucket for the build status
[19:27:18.381] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:18.381] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:56:0) after 1m0s
[19:28:18.400] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:56:0)
[19:28:18.400] Timer tick, asking Buildbucket for the build status
[19:28:18.569] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:18.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:57:0) after 1m0s
[19:29:18.595] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:57:0)
[19:29:18.595] Timer tick, asking Buildbucket for the build status
[19:29:18.742] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:18.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:58:0) after 1m0s
[19:30:18.766] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:58:0)
[19:30:18.766] Timer tick, asking Buildbucket for the build status
[19:30:18.833] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:18.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:59:0) after 1m0s
[19:31:18.853] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:59:0)
[19:31:18.853] Timer tick, asking Buildbucket for the build status
[19:31:18.919] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:18.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:60:0) after 1m0s
[19:32:18.956] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:60:0)
[19:32:18.956] Timer tick, asking Buildbucket for the build status
[19:32:19.036] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:19.036] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:61:0) after 1m0s
[19:33:19.054] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:61:0)
[19:33:19.055] Timer tick, asking Buildbucket for the build status
[19:33:19.269] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:19.269] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:62:0) after 1m0s
[19:34:19.323] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:62:0)
[19:34:19.323] Timer tick, asking Buildbucket for the build status
[19:34:19.595] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:19.595] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:63:0) after 1m0s
[19:35:19.616] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:63:0)
[19:35:19.616] Timer tick, asking Buildbucket for the build status
[19:35:19.687] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:19.687] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:64:0) after 1m0s
[19:36:19.718] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:64:0)
[19:36:19.718] Timer tick, asking Buildbucket for the build status
[19:36:19.871] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:19.871] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:65:0) after 1m0s
[19:37:19.931] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:65:0)
[19:37:19.931] Timer tick, asking Buildbucket for the build status
[19:37:19.989] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:19.989] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:66:0) after 1m0s
[19:38:20.018] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:66:0)
[19:38:20.018] Timer tick, asking Buildbucket for the build status
[19:38:20.075] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:20.075] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:67:0) after 1m0s
[19:39:20.052] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:67:0)
[19:39:20.052] Timer tick, asking Buildbucket for the build status
[19:39:20.320] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:20.320] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:68:0) after 1m0s
[19:40:20.365] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:68:0)
[19:40:20.365] Timer tick, asking Buildbucket for the build status
[19:40:20.684] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:20.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:69:0) after 1m0s
[19:41:20.808] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:69:0)
[19:41:20.808] Timer tick, asking Buildbucket for the build status
[19:41:20.918] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:20.918] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:70:0) after 1m0s
[19:42:20.958] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:70:0)
[19:42:20.958] Timer tick, asking Buildbucket for the build status
[19:42:21.279] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:21.279] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:71:0) after 1m0s
[19:43:21.315] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:71:0)
[19:43:21.315] Timer tick, asking Buildbucket for the build status
[19:43:21.494] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:21.494] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:72:0) after 1m0s
[19:44:21.542] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:72:0)
[19:44:21.542] Timer tick, asking Buildbucket for the build status
[19:44:21.659] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:21.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:73:0) after 1m0s
[19:45:21.741] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:73:0)
[19:45:21.741] Timer tick, asking Buildbucket for the build status
[19:45:21.832] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:21.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:74:0) after 1m0s
[19:46:21.856] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:74:0)
[19:46:21.856] Timer tick, asking Buildbucket for the build status
[19:46:21.914] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:21.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:75:0) after 1m0s
[19:47:21.975] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:75:0)
[19:47:21.975] Timer tick, asking Buildbucket for the build status
[19:47:22.034] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:22.034] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:76:0) after 1m0s
[19:48:22.059] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:76:0)
[19:48:22.059] Timer tick, asking Buildbucket for the build status
[19:48:22.216] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:22.216] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:77:0) after 1m0s
[19:49:22.287] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:77:0)
[19:49:22.287] Timer tick, asking Buildbucket for the build status
[19:49:22.394] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:22.394] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:78:0) after 1m0s
[19:50:22.602] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:78:0)
[19:50:22.602] Timer tick, asking Buildbucket for the build status
[19:50:22.660] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:22.660] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:79:0) after 1m0s
[19:51:22.689] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:79:0)
[19:51:22.689] Timer tick, asking Buildbucket for the build status
[19:51:22.772] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:22.772] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:80:0) after 1m0s
[19:52:22.801] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:80:0)
[19:52:22.801] Timer tick, asking Buildbucket for the build status
[19:52:22.861] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:22.861] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:81:0) after 1m0s
[19:53:22.885] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:81:0)
[19:53:22.885] Timer tick, asking Buildbucket for the build status
[19:53:23.045] Build 8857924378040509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:23.045] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9023354440043530496:82:0) after 1m0s
[19:53:46.264] Received PubSub notification, asking Buildbucket for the build status
[19:53:46.408] Build 8857924378040509712: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:53:46.408] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1610826825230159",
"created_by": "project:fuchsia",
"created_ts": "1610822046201245",
"id": "8857924378040509712",
"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\": \"75a933f39918ce4f4b9481234992895e022787ee\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@75a933f39918ce4f4b9481234992895e022787ee\", \"title\": \"75a933f39918ce4f4b9481234992895e022787ee\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/75a933f39918ce4f4b9481234992895e022787ee\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"75a933f39918ce4f4b9481234992895e022787ee\"}}",
"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-s0wi\"], \"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\": [\"5666-679c9bd\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1610822057931895",
"status": "COMPLETED",
"status_changed_ts": "1610826825972861",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/75a933f39918ce4f4b9481234992895e022787ee",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/75a933f39918ce4f4b9481234992895e022787ee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023354440043530496",
"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/8857924378040509712/+/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:51254b5ca0675310",
"user_agent:luci-scheduler"
],
"updated_ts": "1610826826032408",
"url": "https://ci.chromium.org/b/8857924378040509712",
"utcnow_ts": "1610826826388785"
}
}
[19:53:46.408] Invocation finished in 1h19m41.500093486s with status SUCCEEDED