[16:44:04.891] New invocation is queued and will start shortly
[16:44:07.097] Starting the invocation (attempt 1)
[16:44:07.197] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:44:07.197] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:44:07.198] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9052080599029669488",
"parameters_json": "{\"builder_name\":\"gcc-x64-mac\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/releases/gcc-9\",\"repo\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"c47f6f69745cd41cb7cb00407bf1ff81b2a56124\"},\"id\":\"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@c47f6f69745cd41cb7cb00407bf1ff81b2a56124\",\"title\":\"c47f6f69745cd41cb7cb00407bf1ff81b2a56124\",\"url\":\"https://gnu.googlesource.com/gcc/+/c47f6f69745cd41cb7cb00407bf1ff81b2a56124\"},{\"gitiles\":{\"ref\":\"refs/heads/releases/gcc-9\",\"repo\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"9ca4280a921b0094c7ef131c5c8a63b451ab9a05\"},\"id\":\"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@9ca4280a921b0094c7ef131c5c8a63b451ab9a05\",\"title\":\"9ca4280a921b0094c7ef131c5c8a63b451ab9a05\",\"url\":\"https://gnu.googlesource.com/gcc/+/9ca4280a921b0094c7ef131c5c8a63b451ab9a05\"}]},\"branch\":\"refs/heads/releases/gcc-9\",\"repository\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"9ca4280a921b0094c7ef131c5c8a63b451ab9a05\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-x64-mac",
"scheduler_invocation_id:9052080599029669488",
"scheduler_job_id:fuchsia/prod-gcc-x64-mac",
"user_agent:luci-scheduler",
"buildset:commit/git/9ca4280a921b0094c7ef131c5c8a63b451ab9a05",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/9ca4280a921b0094c7ef131c5c8a63b451ab9a05",
"gitiles_ref:refs/heads/releases/gcc-9"
]
}
[16:44:08.578] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1583426647392470",
"id": "8886650535742873152",
"parameters_json": "{\"builder_name\": \"gcc-x64-mac\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"c47f6f69745cd41cb7cb00407bf1ff81b2a56124\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@c47f6f69745cd41cb7cb00407bf1ff81b2a56124\", \"title\": \"c47f6f69745cd41cb7cb00407bf1ff81b2a56124\", \"url\": \"https://gnu.googlesource.com/gcc/+/c47f6f69745cd41cb7cb00407bf1ff81b2a56124\"}, {\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"9ca4280a921b0094c7ef131c5c8a63b451ab9a05\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@9ca4280a921b0094c7ef131c5c8a63b451ab9a05\", \"title\": \"9ca4280a921b0094c7ef131c5c8a63b451ab9a05\", \"url\": \"https://gnu.googlesource.com/gcc/+/9ca4280a921b0094c7ef131c5c8a63b451ab9a05\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"9ca4280a921b0094c7ef131c5c8a63b451ab9a05\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583426648341908",
"tags": [
"builder:gcc-x64-mac",
"buildset:commit/git/9ca4280a921b0094c7ef131c5c8a63b451ab9a05",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/9ca4280a921b0094c7ef131c5c8a63b451ab9a05",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9052080599029669488",
"scheduler_job_id:fuchsia/prod-gcc-x64-mac",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/fuchsia/buildbucket/cr-buildbucket.appspot.com/8886650535742873152/+/annotations",
"swarming_tag:luci_project:fuchsia",
"swarming_tag:recipe_name:gcc_toolchain",
"swarming_tag:recipe_package:fuchsia/infra/recipe_bundles/fuchsia.googlesource.com/infra/recipes",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1583426648342142",
"url": "https://ci.chromium.org/b/8886650535742873152",
"utcnow_ts": "1583426648563301"
}
}
[16:44:08.578] Task URL: https://ci.chromium.org/b/8886650535742873152
[16:44:08.578] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:2:0) after 1m0s
[16:44:20.369] Received PubSub notification, asking Buildbucket for the build status
[16:44:20.586] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:08.689] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:2:0)
[16:45:08.689] Timer tick, asking Buildbucket for the build status
[16:45:09.195] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:09.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:4:0) after 1m0s
[16:46:09.207] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:4:0)
[16:46:09.207] Timer tick, asking Buildbucket for the build status
[16:46:09.468] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:09.468] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:5:0) after 1m0s
[16:47:09.525] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:5:0)
[16:47:09.525] Timer tick, asking Buildbucket for the build status
[16:47:09.677] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:09.677] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:6:0) after 1m0s
[16:48:09.661] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:6:0)
[16:48:09.661] Timer tick, asking Buildbucket for the build status
[16:48:09.839] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:09.839] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:7:0) after 1m0s
[16:49:09.939] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:7:0)
[16:49:09.939] Timer tick, asking Buildbucket for the build status
[16:49:10.144] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:10.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:8:0) after 1m0s
[16:50:10.253] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:8:0)
[16:50:10.253] Timer tick, asking Buildbucket for the build status
[16:50:10.389] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:10.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:9:0) after 1m0s
[16:51:10.460] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:9:0)
[16:51:10.460] Timer tick, asking Buildbucket for the build status
[16:51:10.562] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:10.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:10:0) after 1m0s
[16:52:10.581] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:10:0)
[16:52:10.581] Timer tick, asking Buildbucket for the build status
[16:52:10.770] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:10.770] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:11:0) after 1m0s
[16:53:11.014] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:11:0)
[16:53:11.014] Timer tick, asking Buildbucket for the build status
[16:53:11.133] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:11.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:12:0) after 1m0s
[16:54:11.237] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:12:0)
[16:54:11.237] Timer tick, asking Buildbucket for the build status
[16:54:11.488] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:11.488] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:13:0) after 1m0s
[16:55:11.640] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:13:0)
[16:55:11.640] Timer tick, asking Buildbucket for the build status
[16:55:12.204] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:12.204] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:14:0) after 1m0s
[16:56:12.256] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:14:0)
[16:56:12.256] Timer tick, asking Buildbucket for the build status
[16:56:12.411] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:12.411] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:15:0) after 1m0s
[16:57:12.470] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:15:0)
[16:57:12.470] Timer tick, asking Buildbucket for the build status
[16:57:12.527] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:12.527] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:16:0) after 1m0s
[16:58:12.534] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:16:0)
[16:58:12.534] Timer tick, asking Buildbucket for the build status
[16:58:12.671] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:12.671] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:17:0) after 1m0s
[16:59:12.719] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:17:0)
[16:59:12.719] Timer tick, asking Buildbucket for the build status
[16:59:12.806] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:12.806] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:18:0) after 1m0s
[17:00:12.833] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:18:0)
[17:00:12.833] Timer tick, asking Buildbucket for the build status
[17:00:12.951] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:12.951] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:19:0) after 1m0s
[17:01:13.176] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:19:0)
[17:01:13.176] Timer tick, asking Buildbucket for the build status
[17:01:13.346] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:13.346] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:20:0) after 1m0s
[17:02:13.606] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:20:0)
[17:02:13.606] Timer tick, asking Buildbucket for the build status
[17:02:13.727] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:13.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:21:0) after 1m0s
[17:03:13.856] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:21:0)
[17:03:13.856] Timer tick, asking Buildbucket for the build status
[17:03:14.130] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:14.130] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:22:0) after 1m0s
[17:04:14.341] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:22:0)
[17:04:14.341] Timer tick, asking Buildbucket for the build status
[17:04:14.448] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:14.448] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:23:0) after 1m0s
[17:05:14.475] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:23:0)
[17:05:14.475] Timer tick, asking Buildbucket for the build status
[17:05:14.698] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:14.698] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:24:0) after 1m0s
[17:06:14.717] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:24:0)
[17:06:14.717] Timer tick, asking Buildbucket for the build status
[17:06:14.863] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:14.863] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:25:0) after 1m0s
[17:07:14.934] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:25:0)
[17:07:14.934] Timer tick, asking Buildbucket for the build status
[17:07:15.063] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:15.063] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:26:0) after 1m0s
[17:08:15.137] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:26:0)
[17:08:15.137] Timer tick, asking Buildbucket for the build status
[17:08:15.446] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:15.446] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:27:0) after 1m0s
[17:09:15.515] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:27:0)
[17:09:15.515] Timer tick, asking Buildbucket for the build status
[17:09:15.648] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:15.648] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:28:0) after 1m0s
[17:10:15.777] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:28:0)
[17:10:15.777] Timer tick, asking Buildbucket for the build status
[17:10:15.883] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:15.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:29:0) after 1m0s
[17:11:16.053] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:29:0)
[17:11:16.053] Timer tick, asking Buildbucket for the build status
[17:11:16.314] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:16.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:30:0) after 1m0s
[17:12:16.389] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:30:0)
[17:12:16.389] Timer tick, asking Buildbucket for the build status
[17:12:16.491] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:16.491] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:31:0) after 1m0s
[17:13:16.553] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:31:0)
[17:13:16.553] Timer tick, asking Buildbucket for the build status
[17:13:16.988] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:16.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:32:0) after 1m0s
[17:14:17.015] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:32:0)
[17:14:17.015] Timer tick, asking Buildbucket for the build status
[17:14:17.143] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:17.143] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:33:0) after 1m0s
[17:15:17.189] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:33:0)
[17:15:17.189] Timer tick, asking Buildbucket for the build status
[17:15:17.317] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:17.317] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:34:0) after 1m0s
[17:16:17.343] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:34:0)
[17:16:17.343] Timer tick, asking Buildbucket for the build status
[17:16:17.531] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:17.531] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:35:0) after 1m0s
[17:17:17.677] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:35:0)
[17:17:17.677] Timer tick, asking Buildbucket for the build status
[17:17:17.794] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:17.794] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:36:0) after 1m0s
[17:18:17.892] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:36:0)
[17:18:17.892] Timer tick, asking Buildbucket for the build status
[17:18:18.379] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:18.379] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:37:0) after 1m0s
[17:19:18.411] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:37:0)
[17:19:18.411] Timer tick, asking Buildbucket for the build status
[17:19:18.524] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:18.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:38:0) after 1m0s
[17:20:18.577] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:38:0)
[17:20:18.577] Timer tick, asking Buildbucket for the build status
[17:20:18.954] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:18.954] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:39:0) after 1m0s
[17:21:18.991] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:39:0)
[17:21:18.991] Timer tick, asking Buildbucket for the build status
[17:21:19.292] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:19.292] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:40:0) after 1m0s
[17:22:19.341] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:40:0)
[17:22:19.341] Timer tick, asking Buildbucket for the build status
[17:22:19.445] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:19.445] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:41:0) after 1m0s
[17:23:19.545] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:41:0)
[17:23:19.545] Timer tick, asking Buildbucket for the build status
[17:23:19.777] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:19.777] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:42:0) after 1m0s
[17:24:19.846] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:42:0)
[17:24:19.846] Timer tick, asking Buildbucket for the build status
[17:24:20.023] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:20.023] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:43:0) after 1m0s
[17:25:20.082] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:43:0)
[17:25:20.082] Timer tick, asking Buildbucket for the build status
[17:25:20.582] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:20.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:44:0) after 1m0s
[17:26:20.624] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:44:0)
[17:26:20.624] Timer tick, asking Buildbucket for the build status
[17:26:20.711] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:20.711] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:45:0) after 1m0s
[17:27:20.800] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:45:0)
[17:27:20.800] Timer tick, asking Buildbucket for the build status
[17:27:21.147] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:21.147] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:46:0) after 1m0s
[17:28:21.220] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:46:0)
[17:28:21.220] Timer tick, asking Buildbucket for the build status
[17:28:21.328] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:21.328] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:47:0) after 1m0s
[17:29:21.415] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:47:0)
[17:29:21.415] Timer tick, asking Buildbucket for the build status
[17:29:21.508] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:21.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:48:0) after 1m0s
[17:30:21.682] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:48:0)
[17:30:21.682] Timer tick, asking Buildbucket for the build status
[17:30:22.009] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:22.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:49:0) after 1m0s
[17:31:22.042] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:49:0)
[17:31:22.042] Timer tick, asking Buildbucket for the build status
[17:31:22.320] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:22.320] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:50:0) after 1m0s
[17:32:22.530] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:50:0)
[17:32:22.530] Timer tick, asking Buildbucket for the build status
[17:32:22.630] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:22.630] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:51:0) after 1m0s
[17:33:22.787] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:51:0)
[17:33:22.787] Timer tick, asking Buildbucket for the build status
[17:33:22.928] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:22.928] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:52:0) after 1m0s
[17:34:23.033] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:52:0)
[17:34:23.033] Timer tick, asking Buildbucket for the build status
[17:34:23.139] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:23.139] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:53:0) after 1m0s
[17:35:23.125] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:53:0)
[17:35:23.125] Timer tick, asking Buildbucket for the build status
[17:35:23.545] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:23.545] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:54:0) after 1m0s
[17:36:23.606] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:54:0)
[17:36:23.606] Timer tick, asking Buildbucket for the build status
[17:36:23.706] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:23.707] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:55:0) after 1m0s
[17:37:23.801] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:55:0)
[17:37:23.801] Timer tick, asking Buildbucket for the build status
[17:37:23.974] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:23.974] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:56:0) after 1m0s
[17:38:24.120] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:56:0)
[17:38:24.120] Timer tick, asking Buildbucket for the build status
[17:38:24.304] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:24.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:57:0) after 1m0s
[17:39:24.414] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:57:0)
[17:39:24.414] Timer tick, asking Buildbucket for the build status
[17:39:24.509] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:24.509] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:58:0) after 1m0s
[17:40:24.530] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:58:0)
[17:40:24.530] Timer tick, asking Buildbucket for the build status
[17:40:24.669] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:24.669] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:59:0) after 1m0s
[17:41:24.874] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:59:0)
[17:41:24.874] Timer tick, asking Buildbucket for the build status
[17:41:25.306] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:25.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:60:0) after 1m0s
[17:42:25.375] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:60:0)
[17:42:25.375] Timer tick, asking Buildbucket for the build status
[17:42:25.487] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:25.487] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:61:0) after 1m0s
[17:43:25.548] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:61:0)
[17:43:25.548] Timer tick, asking Buildbucket for the build status
[17:43:25.716] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:25.716] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:62:0) after 1m0s
[17:44:25.782] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:62:0)
[17:44:25.782] Timer tick, asking Buildbucket for the build status
[17:44:25.877] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:25.877] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:63:0) after 1m0s
[17:45:25.970] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:63:0)
[17:45:25.970] Timer tick, asking Buildbucket for the build status
[17:45:26.082] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:26.083] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:64:0) after 1m0s
[17:46:26.119] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:64:0)
[17:46:26.119] Timer tick, asking Buildbucket for the build status
[17:46:26.400] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:26.400] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:65:0) after 1m0s
[17:47:26.477] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:65:0)
[17:47:26.477] Timer tick, asking Buildbucket for the build status
[17:47:26.620] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:26.620] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:66:0) after 1m0s
[17:48:26.670] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:66:0)
[17:48:26.670] Timer tick, asking Buildbucket for the build status
[17:48:26.892] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:26.892] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:67:0) after 1m0s
[17:49:27.193] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:67:0)
[17:49:27.193] Timer tick, asking Buildbucket for the build status
[17:49:27.325] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:27.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:68:0) after 1m0s
[17:50:27.430] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:68:0)
[17:50:27.430] Timer tick, asking Buildbucket for the build status
[17:50:27.684] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:27.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:69:0) after 1m0s
[17:51:27.745] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:69:0)
[17:51:27.745] Timer tick, asking Buildbucket for the build status
[17:51:27.904] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:27.904] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:70:0) after 1m0s
[17:52:27.917] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:70:0)
[17:52:27.917] Timer tick, asking Buildbucket for the build status
[17:52:28.015] Build 8886650535742873152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:28.015] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052080599029669488:71:0) after 1m0s
[17:53:23.820] Received PubSub notification, asking Buildbucket for the build status
[17:53:24.271] Build 8886650535742873152: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:53:24.271] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1583430802687340",
"created_by": "project:fuchsia",
"created_ts": "1583426647392470",
"id": "8886650535742873152",
"parameters_json": "{\"builder_name\": \"gcc-x64-mac\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"c47f6f69745cd41cb7cb00407bf1ff81b2a56124\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@c47f6f69745cd41cb7cb00407bf1ff81b2a56124\", \"title\": \"c47f6f69745cd41cb7cb00407bf1ff81b2a56124\", \"url\": \"https://gnu.googlesource.com/gcc/+/c47f6f69745cd41cb7cb00407bf1ff81b2a56124\"}, {\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"9ca4280a921b0094c7ef131c5c8a63b451ab9a05\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@9ca4280a921b0094c7ef131c5c8a63b451ab9a05\", \"title\": \"9ca4280a921b0094c7ef131c5c8a63b451ab9a05\", \"url\": \"https://gnu.googlesource.com/gcc/+/9ca4280a921b0094c7ef131c5c8a63b451ab9a05\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"9ca4280a921b0094c7ef131c5c8a63b451ab9a05\"}}",
"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/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"c47f6f69745cd41cb7cb00407bf1ff81b2a56124\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@c47f6f69745cd41cb7cb00407bf1ff81b2a56124\", \"title\": \"c47f6f69745cd41cb7cb00407bf1ff81b2a56124\", \"url\": \"https://gnu.googlesource.com/gcc/+/c47f6f69745cd41cb7cb00407bf1ff81b2a56124\"}, {\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"9ca4280a921b0094c7ef131c5c8a63b451ab9a05\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@9ca4280a921b0094c7ef131c5c8a63b451ab9a05\", \"title\": \"9ca4280a921b0094c7ef131c5c8a63b451ab9a05\", \"url\": \"https://gnu.googlesource.com/gcc/+/9ca4280a921b0094c7ef131c5c8a63b451ab9a05\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"build386-a9\", \"branch\": \"refs/heads/releases/gcc-9\", \"buildername\": \"gcc-x64-mac\", \"git_revision\": \"9ca4280a921b0094c7ef131c5c8a63b451ab9a05,d1faf7ca0a9ecbc7f89998638e5cf08d3dca6e84\", \"instance_id\": \"Jc89uz0u_Q0jVqueP2w9GT85X-_E5c9X6PttmYw9DuQC\", \"isolated\": \"171f5263c0d6c3ee5204bc452a69201b3fbeca27\", \"mastername\": \"gcc\", \"package\": \"fuchsia/third_party/gcc/mac-amd64\", \"path_config\": \"generic\", \"recipe\": \"gcc_toolchain\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"9ca4280a921b0094c7ef131c5c8a63b451ab9a05\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"24\"], \"cpu\": [\"x64\", \"x86\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build386-a9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.fuchsia.prod\"], \"python\": [\"2.7.10\"], \"role\": [\"builder\"], \"server_version\": [\"4851-268d16b\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-mtv\", \"us-mtv-chops\", \"us-mtv-chops-a9\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1583426659060550",
"status": "COMPLETED",
"status_changed_ts": "1583430803386305",
"tags": [
"builder:gcc-x64-mac",
"buildset:commit/git/9ca4280a921b0094c7ef131c5c8a63b451ab9a05",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/9ca4280a921b0094c7ef131c5c8a63b451ab9a05",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9052080599029669488",
"scheduler_job_id:fuchsia/prod-gcc-x64-mac",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/fuchsia/buildbucket/cr-buildbucket.appspot.com/8886650535742873152/+/annotations",
"swarming_tag:luci_project:fuchsia",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:gcc_toolchain",
"swarming_tag:recipe_package:fuchsia/infra/recipe_bundles/fuchsia.googlesource.com/infra/recipes",
"swarming_task_id:4ac466c2a8ff6510",
"user_agent:luci-scheduler"
],
"updated_ts": "1583430803468757",
"url": "https://ci.chromium.org/b/8886650535742873152",
"utcnow_ts": "1583430804263258"
}
}
[17:53:24.271] Invocation finished in 1h9m19.39739267s with status SUCCEEDED