[16:44:20.146] New invocation is queued and will start shortly
[16:44:21.606] Starting the invocation (attempt 1)
[16:44:21.643] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:44:21.643] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:44:21.644] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9052171180002673696",
"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\":\"bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\"},\"id\":\"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\",\"title\":\"bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\",\"url\":\"https://gnu.googlesource.com/gcc/+/bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\"}]},\"branch\":\"refs/heads/releases/gcc-9\",\"repository\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-x64-mac",
"scheduler_invocation_id:9052171180002673696",
"scheduler_job_id:fuchsia/prod-gcc-x64-mac",
"user_agent:luci-scheduler",
"buildset:commit/git/bde2e6e59829f746f3b1191ca4bfedf3313ad6eb",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/bde2e6e59829f746f3b1191ca4bfedf3313ad6eb",
"gitiles_ref:refs/heads/releases/gcc-9"
]
}
[16:44:22.307] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1583340261743600",
"id": "8886741117660975728",
"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\": \"bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\", \"title\": \"bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\", \"url\": \"https://gnu.googlesource.com/gcc/+/bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583340262059372",
"tags": [
"builder:gcc-x64-mac",
"buildset:commit/git/bde2e6e59829f746f3b1191ca4bfedf3313ad6eb",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/bde2e6e59829f746f3b1191ca4bfedf3313ad6eb",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9052171180002673696",
"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/8886741117660975728/+/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": "1583340262059494",
"url": "https://ci.chromium.org/b/8886741117660975728",
"utcnow_ts": "1583340262297703"
}
}
[16:44:22.307] Task URL: https://ci.chromium.org/b/8886741117660975728
[16:44:22.307] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:2:0) after 1m0s
[16:44:33.008] Received PubSub notification, asking Buildbucket for the build status
[16:44:33.251] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:22.437] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:2:0)
[16:45:22.437] Timer tick, asking Buildbucket for the build status
[16:45:22.680] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:22.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:4:0) after 1m0s
[16:46:22.782] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:4:0)
[16:46:22.782] Timer tick, asking Buildbucket for the build status
[16:46:22.892] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:22.892] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:5:0) after 1m0s
[16:47:22.989] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:5:0)
[16:47:22.989] Timer tick, asking Buildbucket for the build status
[16:47:23.255] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:23.255] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:6:0) after 1m0s
[16:48:23.334] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:6:0)
[16:48:23.334] Timer tick, asking Buildbucket for the build status
[16:48:24.378] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:24.378] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:7:0) after 1m0s
[16:49:24.407] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:7:0)
[16:49:24.407] Timer tick, asking Buildbucket for the build status
[16:49:24.523] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:24.523] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:8:0) after 1m0s
[16:50:24.533] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:8:0)
[16:50:24.533] Timer tick, asking Buildbucket for the build status
[16:50:24.657] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:24.657] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:9:0) after 1m0s
[16:51:24.705] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:9:0)
[16:51:24.705] Timer tick, asking Buildbucket for the build status
[16:51:24.813] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:24.813] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:10:0) after 1m0s
[16:52:24.931] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:10:0)
[16:52:24.931] Timer tick, asking Buildbucket for the build status
[16:52:25.052] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:25.052] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:11:0) after 1m0s
[16:53:25.573] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:11:0)
[16:53:25.573] Timer tick, asking Buildbucket for the build status
[16:53:25.701] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:25.701] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:12:0) after 1m0s
[16:54:25.925] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:12:0)
[16:54:25.925] Timer tick, asking Buildbucket for the build status
[16:54:26.087] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:26.087] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:13:0) after 1m0s
[16:55:26.231] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:13:0)
[16:55:26.231] Timer tick, asking Buildbucket for the build status
[16:55:26.566] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:26.566] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:14:0) after 1m0s
[16:56:26.656] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:14:0)
[16:56:26.656] Timer tick, asking Buildbucket for the build status
[16:56:26.826] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:26.826] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:15:0) after 1m0s
[16:57:26.946] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:15:0)
[16:57:26.947] Timer tick, asking Buildbucket for the build status
[16:57:27.078] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:27.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:16:0) after 1m0s
[16:58:27.140] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:16:0)
[16:58:27.140] Timer tick, asking Buildbucket for the build status
[16:58:27.567] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:27.567] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:17:0) after 1m0s
[16:59:27.629] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:17:0)
[16:59:27.629] Timer tick, asking Buildbucket for the build status
[16:59:27.722] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:27.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:18:0) after 1m0s
[17:00:27.699] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:18:0)
[17:00:27.699] Timer tick, asking Buildbucket for the build status
[17:00:27.833] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:27.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:19:0) after 1m0s
[17:01:27.927] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:19:0)
[17:01:27.927] Timer tick, asking Buildbucket for the build status
[17:01:28.246] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:28.246] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:20:0) after 1m0s
[17:02:28.234] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:20:0)
[17:02:28.234] Timer tick, asking Buildbucket for the build status
[17:02:28.330] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:28.330] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:21:0) after 1m0s
[17:03:28.421] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:21:0)
[17:03:28.421] Timer tick, asking Buildbucket for the build status
[17:03:28.519] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:28.519] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:22:0) after 1m0s
[17:04:28.541] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:22:0)
[17:04:28.541] Timer tick, asking Buildbucket for the build status
[17:04:28.938] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:28.938] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:23:0) after 1m0s
[17:05:28.997] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:23:0)
[17:05:28.997] Timer tick, asking Buildbucket for the build status
[17:05:29.168] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:29.168] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:24:0) after 1m0s
[17:06:29.229] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:24:0)
[17:06:29.229] Timer tick, asking Buildbucket for the build status
[17:06:29.359] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:29.359] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:25:0) after 1m0s
[17:07:29.865] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:25:0)
[17:07:29.865] Timer tick, asking Buildbucket for the build status
[17:07:30.010] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:30.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:26:0) after 1m0s
[17:08:30.181] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:26:0)
[17:08:30.181] Timer tick, asking Buildbucket for the build status
[17:08:30.287] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:30.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:27:0) after 1m0s
[17:09:30.434] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:27:0)
[17:09:30.434] Timer tick, asking Buildbucket for the build status
[17:09:30.531] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:30.531] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:28:0) after 1m0s
[17:10:30.576] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:28:0)
[17:10:30.576] Timer tick, asking Buildbucket for the build status
[17:10:30.792] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:30.792] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:29:0) after 1m0s
[17:11:30.925] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:29:0)
[17:11:30.925] Timer tick, asking Buildbucket for the build status
[17:11:31.023] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:31.023] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:30:0) after 1m0s
[17:12:31.012] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:30:0)
[17:12:31.012] Timer tick, asking Buildbucket for the build status
[17:12:31.224] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:31.224] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:31:0) after 1m0s
[17:13:31.423] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:31:0)
[17:13:31.423] Timer tick, asking Buildbucket for the build status
[17:13:31.649] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:31.649] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:32:0) after 1m0s
[17:14:31.681] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:32:0)
[17:14:31.681] Timer tick, asking Buildbucket for the build status
[17:14:31.784] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:31.784] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:33:0) after 1m0s
[17:15:31.948] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:33:0)
[17:15:31.948] Timer tick, asking Buildbucket for the build status
[17:15:32.365] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:32.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:34:0) after 1m0s
[17:16:32.483] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:34:0)
[17:16:32.483] Timer tick, asking Buildbucket for the build status
[17:16:32.636] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:32.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:35:0) after 1m0s
[17:17:32.759] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:35:0)
[17:17:32.759] Timer tick, asking Buildbucket for the build status
[17:17:32.873] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:32.873] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:36:0) after 1m0s
[17:18:33.015] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:36:0)
[17:18:33.015] Timer tick, asking Buildbucket for the build status
[17:18:33.105] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:33.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:37:0) after 1m0s
[17:19:33.195] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:37:0)
[17:19:33.195] Timer tick, asking Buildbucket for the build status
[17:19:33.389] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:33.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:38:0) after 1m0s
[17:20:33.984] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:38:0)
[17:20:33.984] Timer tick, asking Buildbucket for the build status
[17:20:34.105] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:34.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:39:0) after 1m0s
[17:21:34.251] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:39:0)
[17:21:34.251] Timer tick, asking Buildbucket for the build status
[17:21:34.436] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:34.436] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:40:0) after 1m0s
[17:22:34.495] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:40:0)
[17:22:34.495] Timer tick, asking Buildbucket for the build status
[17:22:35.609] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:35.609] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:41:0) after 1m0s
[17:23:35.699] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:41:0)
[17:23:35.699] Timer tick, asking Buildbucket for the build status
[17:23:35.805] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:35.805] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:42:0) after 1m0s
[17:24:35.878] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:42:0)
[17:24:35.878] Timer tick, asking Buildbucket for the build status
[17:24:36.046] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:36.046] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:43:0) after 1m0s
[17:25:36.137] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:43:0)
[17:25:36.137] Timer tick, asking Buildbucket for the build status
[17:25:36.922] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:36.922] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:44:0) after 1m0s
[17:26:37.178] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:44:0)
[17:26:37.178] Timer tick, asking Buildbucket for the build status
[17:26:37.303] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:37.303] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:45:0) after 1m0s
[17:27:37.338] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:45:0)
[17:27:37.338] Timer tick, asking Buildbucket for the build status
[17:27:37.844] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:37.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:46:0) after 1m0s
[17:28:37.896] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:46:0)
[17:28:37.896] Timer tick, asking Buildbucket for the build status
[17:28:38.064] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:38.064] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:47:0) after 1m0s
[17:29:38.154] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:47:0)
[17:29:38.154] Timer tick, asking Buildbucket for the build status
[17:29:38.373] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:38.373] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:48:0) after 1m0s
[17:30:38.448] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:48:0)
[17:30:38.448] Timer tick, asking Buildbucket for the build status
[17:30:38.639] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:38.639] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:49:0) after 1m0s
[17:31:38.685] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:49:0)
[17:31:38.685] Timer tick, asking Buildbucket for the build status
[17:31:38.870] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:38.870] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:50:0) after 1m0s
[17:32:38.891] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:50:0)
[17:32:38.891] Timer tick, asking Buildbucket for the build status
[17:32:39.297] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:39.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:51:0) after 1m0s
[17:33:39.322] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:51:0)
[17:33:39.322] Timer tick, asking Buildbucket for the build status
[17:33:39.570] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:39.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:52:0) after 1m0s
[17:34:39.680] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:52:0)
[17:34:39.680] Timer tick, asking Buildbucket for the build status
[17:34:39.774] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:39.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:53:0) after 1m0s
[17:35:39.815] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:53:0)
[17:35:39.815] Timer tick, asking Buildbucket for the build status
[17:35:39.971] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:39.971] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:54:0) after 1m0s
[17:36:40.048] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:54:0)
[17:36:40.048] Timer tick, asking Buildbucket for the build status
[17:36:40.191] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:40.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:55:0) after 1m0s
[17:37:40.229] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:55:0)
[17:37:40.229] Timer tick, asking Buildbucket for the build status
[17:37:40.477] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:40.477] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:56:0) after 1m0s
[17:38:40.482] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:56:0)
[17:38:40.482] Timer tick, asking Buildbucket for the build status
[17:38:40.668] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:40.668] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:57:0) after 1m0s
[17:39:40.748] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:57:0)
[17:39:40.748] Timer tick, asking Buildbucket for the build status
[17:39:40.907] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:40.907] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:58:0) after 1m0s
[17:40:40.932] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:58:0)
[17:40:40.932] Timer tick, asking Buildbucket for the build status
[17:40:41.165] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:41.165] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:59:0) after 1m0s
[17:41:41.208] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:59:0)
[17:41:41.208] Timer tick, asking Buildbucket for the build status
[17:41:41.504] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:41.504] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:60:0) after 1m0s
[17:42:41.592] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:60:0)
[17:42:41.592] Timer tick, asking Buildbucket for the build status
[17:42:41.759] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:41.759] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:61:0) after 1m0s
[17:43:41.782] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:61:0)
[17:43:41.782] Timer tick, asking Buildbucket for the build status
[17:43:42.945] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:42.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:62:0) after 1m0s
[17:44:42.993] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:62:0)
[17:44:42.993] Timer tick, asking Buildbucket for the build status
[17:44:43.166] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:43.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:63:0) after 1m0s
[17:45:43.165] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:63:0)
[17:45:43.165] Timer tick, asking Buildbucket for the build status
[17:45:43.308] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:43.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:64:0) after 1m0s
[17:46:43.376] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:64:0)
[17:46:43.376] Timer tick, asking Buildbucket for the build status
[17:46:43.481] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:43.481] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:65:0) after 1m0s
[17:47:43.585] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:65:0)
[17:47:43.586] Timer tick, asking Buildbucket for the build status
[17:47:43.713] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:43.713] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:66:0) after 1m0s
[17:48:43.774] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:66:0)
[17:48:43.774] Timer tick, asking Buildbucket for the build status
[17:48:43.907] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:43.907] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:67:0) after 1m0s
[17:49:43.974] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:67:0)
[17:49:43.974] Timer tick, asking Buildbucket for the build status
[17:49:44.124] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:44.124] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:68:0) after 1m0s
[17:50:44.189] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:68:0)
[17:50:44.189] Timer tick, asking Buildbucket for the build status
[17:50:44.460] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:44.460] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:69:0) after 1m0s
[17:51:44.516] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:69:0)
[17:51:44.516] Timer tick, asking Buildbucket for the build status
[17:51:45.674] Build 8886741117660975728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:45.674] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052171180002673696:70:0) after 1m0s
[17:51:47.031] Received PubSub notification, asking Buildbucket for the build status
[17:51:47.187] Build 8886741117660975728: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:51:47.187] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1583344305067563",
"created_by": "project:fuchsia",
"created_ts": "1583340261743600",
"id": "8886741117660975728",
"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\": \"bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\", \"title\": \"bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\", \"url\": \"https://gnu.googlesource.com/gcc/+/bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\"}}",
"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\": \"bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\", \"title\": \"bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\", \"url\": \"https://gnu.googlesource.com/gcc/+/bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"build385-a9\", \"branch\": \"refs/heads/releases/gcc-9\", \"buildername\": \"gcc-x64-mac\", \"git_revision\": \"bde2e6e59829f746f3b1191ca4bfedf3313ad6eb,45830fd60e3c7b694dfa03f6fc1e7de431a3fcd1\", \"instance_id\": \"KNOeVMCq9NqI-hO_NlTLW1n8GZ-Gi4Ttw0AVaIf67IIC\", \"isolated\": \"6c1be338ee650ee6cec95c67506500ccbebcbce7\", \"mastername\": \"gcc\", \"package\": \"fuchsia/third_party/gcc/mac-amd64\", \"path_config\": \"generic\", \"recipe\": \"gcc_toolchain\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"bde2e6e59829f746f3b1191ca4bfedf3313ad6eb\"}, \"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\": [\"build385-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": "1583340272371197",
"status": "COMPLETED",
"status_changed_ts": "1583344306088113",
"tags": [
"builder:gcc-x64-mac",
"buildset:commit/git/bde2e6e59829f746f3b1191ca4bfedf3313ad6eb",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/bde2e6e59829f746f3b1191ca4bfedf3313ad6eb",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9052171180002673696",
"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/8886741117660975728/+/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:4abf409c59678910",
"user_agent:luci-scheduler"
],
"updated_ts": "1583344306186079",
"url": "https://ci.chromium.org/b/8886741117660975728",
"utcnow_ts": "1583344307177551"
}
}
[17:51:47.187] Invocation finished in 1h7m27.061346211s with status SUCCEEDED