[21:43:37.163] New invocation is queued and will start shortly
[21:43:41.987] Starting the invocation (attempt 1)
[21:43:42.086] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:43:42.086] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:43:42.086] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9052786529481637520",
"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\":\"65e894738f629a388847f38687c9af2b05233526\"},\"id\":\"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@65e894738f629a388847f38687c9af2b05233526\",\"title\":\"65e894738f629a388847f38687c9af2b05233526\",\"url\":\"https://gnu.googlesource.com/gcc/+/65e894738f629a388847f38687c9af2b05233526\"},{\"gitiles\":{\"ref\":\"refs/heads/releases/gcc-9\",\"repo\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"096ba1951f5e67dfa4ed270753e29d652bc69fa9\"},\"id\":\"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@096ba1951f5e67dfa4ed270753e29d652bc69fa9\",\"title\":\"096ba1951f5e67dfa4ed270753e29d652bc69fa9\",\"url\":\"https://gnu.googlesource.com/gcc/+/096ba1951f5e67dfa4ed270753e29d652bc69fa9\"}]},\"branch\":\"refs/heads/releases/gcc-9\",\"repository\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"096ba1951f5e67dfa4ed270753e29d652bc69fa9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-x64-mac",
"scheduler_invocation_id:9052786529481637520",
"scheduler_job_id:fuchsia/prod-gcc-x64-mac",
"user_agent:luci-scheduler",
"buildset:commit/git/096ba1951f5e67dfa4ed270753e29d652bc69fa9",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/096ba1951f5e67dfa4ed270753e29d652bc69fa9",
"gitiles_ref:refs/heads/releases/gcc-9"
]
}
[21:43:42.939] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1582753422302344",
"id": "8887356463414491760",
"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\": \"65e894738f629a388847f38687c9af2b05233526\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@65e894738f629a388847f38687c9af2b05233526\", \"title\": \"65e894738f629a388847f38687c9af2b05233526\", \"url\": \"https://gnu.googlesource.com/gcc/+/65e894738f629a388847f38687c9af2b05233526\"}, {\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"096ba1951f5e67dfa4ed270753e29d652bc69fa9\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@096ba1951f5e67dfa4ed270753e29d652bc69fa9\", \"title\": \"096ba1951f5e67dfa4ed270753e29d652bc69fa9\", \"url\": \"https://gnu.googlesource.com/gcc/+/096ba1951f5e67dfa4ed270753e29d652bc69fa9\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"096ba1951f5e67dfa4ed270753e29d652bc69fa9\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582753422742012",
"tags": [
"builder:gcc-x64-mac",
"buildset:commit/git/096ba1951f5e67dfa4ed270753e29d652bc69fa9",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/096ba1951f5e67dfa4ed270753e29d652bc69fa9",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9052786529481637520",
"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/8887356463414491760/+/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": "1582753422742162",
"url": "https://ci.chromium.org/b/8887356463414491760",
"utcnow_ts": "1582753422924495"
}
}
[21:43:42.939] Task URL: https://ci.chromium.org/b/8887356463414491760
[21:43:42.939] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:2:0) after 1m0s
[21:44:23.446] Received PubSub notification, asking Buildbucket for the build status
[21:44:23.568] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:42.978] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:2:0)
[21:44:42.978] Timer tick, asking Buildbucket for the build status
[21:44:43.130] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:43.130] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:4:0) after 1m0s
[21:45:43.262] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:4:0)
[21:45:43.262] Timer tick, asking Buildbucket for the build status
[21:45:43.461] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:43.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:5:0) after 1m0s
[21:46:43.491] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:5:0)
[21:46:43.491] Timer tick, asking Buildbucket for the build status
[21:46:43.844] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:43.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:6:0) after 1m0s
[21:47:43.944] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:6:0)
[21:47:43.944] Timer tick, asking Buildbucket for the build status
[21:47:44.958] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:44.958] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:7:0) after 1m0s
[21:48:45.125] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:7:0)
[21:48:45.125] Timer tick, asking Buildbucket for the build status
[21:48:45.403] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:45.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:8:0) after 1m0s
[21:49:45.553] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:8:0)
[21:49:45.553] Timer tick, asking Buildbucket for the build status
[21:49:45.659] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:45.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:9:0) after 1m0s
[21:50:45.811] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:9:0)
[21:50:45.811] Timer tick, asking Buildbucket for the build status
[21:50:45.905] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:45.905] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:10:0) after 1m0s
[21:51:45.974] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:10:0)
[21:51:45.974] Timer tick, asking Buildbucket for the build status
[21:51:46.077] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:46.077] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:11:0) after 1m0s
[21:52:46.136] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:11:0)
[21:52:46.136] Timer tick, asking Buildbucket for the build status
[21:52:46.259] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:46.259] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:12:0) after 1m0s
[21:53:46.338] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:12:0)
[21:53:46.338] Timer tick, asking Buildbucket for the build status
[21:53:46.534] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:46.534] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:13:0) after 1m0s
[21:54:46.585] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:13:0)
[21:54:46.585] Timer tick, asking Buildbucket for the build status
[21:54:46.718] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:46.718] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:14:0) after 1m0s
[21:55:46.785] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:14:0)
[21:55:46.785] Timer tick, asking Buildbucket for the build status
[21:55:47.067] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:47.067] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:15:0) after 1m0s
[21:56:47.152] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:15:0)
[21:56:47.152] Timer tick, asking Buildbucket for the build status
[21:56:47.234] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:47.234] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:16:0) after 1m0s
[21:57:47.320] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:16:0)
[21:57:47.320] Timer tick, asking Buildbucket for the build status
[21:57:47.400] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:47.400] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:17:0) after 1m0s
[21:58:47.461] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:17:0)
[21:58:47.461] Timer tick, asking Buildbucket for the build status
[21:58:47.530] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:47.530] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:18:0) after 1m0s
[21:59:47.595] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:18:0)
[21:59:47.595] Timer tick, asking Buildbucket for the build status
[21:59:47.793] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:47.793] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:19:0) after 1m0s
[22:00:47.823] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:19:0)
[22:00:47.823] Timer tick, asking Buildbucket for the build status
[22:00:48.028] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:48.028] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:20:0) after 1m0s
[22:01:48.053] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:20:0)
[22:01:48.053] Timer tick, asking Buildbucket for the build status
[22:01:48.203] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:48.203] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:21:0) after 1m0s
[22:02:48.295] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:21:0)
[22:02:48.295] Timer tick, asking Buildbucket for the build status
[22:02:48.457] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:48.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:22:0) after 1m0s
[22:03:48.544] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:22:0)
[22:03:48.544] Timer tick, asking Buildbucket for the build status
[22:03:48.851] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:48.851] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:23:0) after 1m0s
[22:04:48.936] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:23:0)
[22:04:48.936] Timer tick, asking Buildbucket for the build status
[22:04:49.128] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:49.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:24:0) after 1m0s
[22:05:49.214] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:24:0)
[22:05:49.214] Timer tick, asking Buildbucket for the build status
[22:05:49.359] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:49.359] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:25:0) after 1m0s
[22:06:49.379] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:25:0)
[22:06:49.379] Timer tick, asking Buildbucket for the build status
[22:06:49.658] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:49.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:26:0) after 1m0s
[22:07:49.747] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:26:0)
[22:07:49.747] Timer tick, asking Buildbucket for the build status
[22:07:50.022] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:50.022] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:27:0) after 1m0s
[22:08:50.099] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:27:0)
[22:08:50.099] Timer tick, asking Buildbucket for the build status
[22:08:50.253] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:50.253] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:28:0) after 1m0s
[22:09:50.334] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:28:0)
[22:09:50.334] Timer tick, asking Buildbucket for the build status
[22:09:50.442] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:50.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:29:0) after 1m0s
[22:10:50.479] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:29:0)
[22:10:50.479] Timer tick, asking Buildbucket for the build status
[22:10:50.608] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:50.608] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:30:0) after 1m0s
[22:11:50.673] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:30:0)
[22:11:50.673] Timer tick, asking Buildbucket for the build status
[22:11:50.982] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:50.982] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:31:0) after 1m0s
[22:12:50.994] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:31:0)
[22:12:50.994] Timer tick, asking Buildbucket for the build status
[22:12:51.182] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:51.182] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:32:0) after 1m0s
[22:13:51.243] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:32:0)
[22:13:51.243] Timer tick, asking Buildbucket for the build status
[22:13:51.490] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:51.490] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:33:0) after 1m0s
[22:14:51.539] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:33:0)
[22:14:51.539] Timer tick, asking Buildbucket for the build status
[22:14:51.885] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:51.885] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:34:0) after 1m0s
[22:15:52.015] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:34:0)
[22:15:52.015] Timer tick, asking Buildbucket for the build status
[22:15:52.125] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:52.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:35:0) after 1m0s
[22:16:52.323] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:35:0)
[22:16:52.323] Timer tick, asking Buildbucket for the build status
[22:16:52.548] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:52.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:36:0) after 1m0s
[22:17:52.566] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:36:0)
[22:17:52.566] Timer tick, asking Buildbucket for the build status
[22:17:52.712] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:52.712] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:37:0) after 1m0s
[22:18:52.708] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:37:0)
[22:18:52.708] Timer tick, asking Buildbucket for the build status
[22:18:53.143] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:53.143] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:38:0) after 1m0s
[22:19:53.248] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:38:0)
[22:19:53.248] Timer tick, asking Buildbucket for the build status
[22:19:53.646] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:53.646] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:39:0) after 1m0s
[22:20:53.701] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:39:0)
[22:20:53.701] Timer tick, asking Buildbucket for the build status
[22:20:53.813] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:53.813] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:40:0) after 1m0s
[22:21:53.813] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:40:0)
[22:21:53.813] Timer tick, asking Buildbucket for the build status
[22:21:54.045] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:54.045] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:41:0) after 1m0s
[22:22:54.067] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:41:0)
[22:22:54.067] Timer tick, asking Buildbucket for the build status
[22:22:54.213] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:54.213] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:42:0) after 1m0s
[22:23:54.248] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:42:0)
[22:23:54.248] Timer tick, asking Buildbucket for the build status
[22:23:54.368] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:54.368] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:43:0) after 1m0s
[22:24:54.423] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:43:0)
[22:24:54.423] Timer tick, asking Buildbucket for the build status
[22:24:54.568] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:54.568] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:44:0) after 1m0s
[22:25:54.599] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:44:0)
[22:25:54.599] Timer tick, asking Buildbucket for the build status
[22:25:54.811] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:54.811] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:45:0) after 1m0s
[22:26:54.788] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:45:0)
[22:26:54.788] Timer tick, asking Buildbucket for the build status
[22:26:54.929] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:54.929] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:46:0) after 1m0s
[22:27:54.963] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:46:0)
[22:27:54.963] Timer tick, asking Buildbucket for the build status
[22:27:55.366] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:55.366] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:47:0) after 1m0s
[22:28:55.343] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:47:0)
[22:28:55.343] Timer tick, asking Buildbucket for the build status
[22:28:55.736] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:55.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:48:0) after 1m0s
[22:29:55.760] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:48:0)
[22:29:55.760] Timer tick, asking Buildbucket for the build status
[22:29:55.968] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:55.968] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:49:0) after 1m0s
[22:30:56.016] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:49:0)
[22:30:56.016] Timer tick, asking Buildbucket for the build status
[22:30:56.272] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:56.272] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:50:0) after 1m0s
[22:31:56.284] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:50:0)
[22:31:56.284] Timer tick, asking Buildbucket for the build status
[22:31:56.594] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:56.594] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:51:0) after 1m0s
[22:32:56.645] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:51:0)
[22:32:56.645] Timer tick, asking Buildbucket for the build status
[22:32:56.887] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:56.887] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:52:0) after 1m0s
[22:33:56.954] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:52:0)
[22:33:56.954] Timer tick, asking Buildbucket for the build status
[22:33:57.088] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:57.088] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:53:0) after 1m0s
[22:34:57.118] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:53:0)
[22:34:57.118] Timer tick, asking Buildbucket for the build status
[22:34:57.801] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:57.801] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:54:0) after 1m0s
[22:35:57.876] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:54:0)
[22:35:57.876] Timer tick, asking Buildbucket for the build status
[22:35:58.384] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:58.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:55:0) after 1m0s
[22:36:58.531] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:55:0)
[22:36:58.531] Timer tick, asking Buildbucket for the build status
[22:36:58.619] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:58.619] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:56:0) after 1m0s
[22:37:58.647] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:56:0)
[22:37:58.647] Timer tick, asking Buildbucket for the build status
[22:37:58.827] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:58.827] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:57:0) after 1m0s
[22:38:58.852] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:57:0)
[22:38:58.852] Timer tick, asking Buildbucket for the build status
[22:38:59.078] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:59.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:58:0) after 1m0s
[22:39:59.108] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:58:0)
[22:39:59.108] Timer tick, asking Buildbucket for the build status
[22:39:59.284] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:59.284] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:59:0) after 1m0s
[22:40:59.320] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:59:0)
[22:40:59.320] Timer tick, asking Buildbucket for the build status
[22:40:59.726] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:59.726] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:60:0) after 1m0s
[22:41:59.747] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:60:0)
[22:41:59.747] Timer tick, asking Buildbucket for the build status
[22:41:59.849] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:59.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:61:0) after 1m0s
[22:42:59.984] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:61:0)
[22:42:59.984] Timer tick, asking Buildbucket for the build status
[22:43:00.154] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:00.154] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:62:0) after 1m0s
[22:44:00.308] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:62:0)
[22:44:00.308] Timer tick, asking Buildbucket for the build status
[22:44:00.508] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:00.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:63:0) after 1m0s
[22:45:00.682] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:63:0)
[22:45:00.682] Timer tick, asking Buildbucket for the build status
[22:45:00.799] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:00.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:64:0) after 1m0s
[22:46:00.840] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:64:0)
[22:46:00.840] Timer tick, asking Buildbucket for the build status
[22:46:01.455] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:01.456] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:65:0) after 1m0s
[22:47:01.637] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:65:0)
[22:47:01.637] Timer tick, asking Buildbucket for the build status
[22:47:01.749] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:01.749] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:66:0) after 1m0s
[22:48:01.800] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:66:0)
[22:48:01.800] Timer tick, asking Buildbucket for the build status
[22:48:02.090] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:02.090] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:67:0) after 1m0s
[22:49:02.180] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:67:0)
[22:49:02.180] Timer tick, asking Buildbucket for the build status
[22:49:02.676] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:02.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:68:0) after 1m0s
[22:50:02.722] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:68:0)
[22:50:02.722] Timer tick, asking Buildbucket for the build status
[22:50:02.955] Build 8887356463414491760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:02.955] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-x64-mac:9052786529481637520:69:0) after 1m0s
[22:50:40.004] Received PubSub notification, asking Buildbucket for the build status
[22:50:40.099] Build 8887356463414491760: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:50:40.099] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1582757439261811",
"created_by": "project:fuchsia",
"created_ts": "1582753422302344",
"id": "8887356463414491760",
"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\": \"65e894738f629a388847f38687c9af2b05233526\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@65e894738f629a388847f38687c9af2b05233526\", \"title\": \"65e894738f629a388847f38687c9af2b05233526\", \"url\": \"https://gnu.googlesource.com/gcc/+/65e894738f629a388847f38687c9af2b05233526\"}, {\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"096ba1951f5e67dfa4ed270753e29d652bc69fa9\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@096ba1951f5e67dfa4ed270753e29d652bc69fa9\", \"title\": \"096ba1951f5e67dfa4ed270753e29d652bc69fa9\", \"url\": \"https://gnu.googlesource.com/gcc/+/096ba1951f5e67dfa4ed270753e29d652bc69fa9\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"096ba1951f5e67dfa4ed270753e29d652bc69fa9\"}}",
"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\": \"65e894738f629a388847f38687c9af2b05233526\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@65e894738f629a388847f38687c9af2b05233526\", \"title\": \"65e894738f629a388847f38687c9af2b05233526\", \"url\": \"https://gnu.googlesource.com/gcc/+/65e894738f629a388847f38687c9af2b05233526\"}, {\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"096ba1951f5e67dfa4ed270753e29d652bc69fa9\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@096ba1951f5e67dfa4ed270753e29d652bc69fa9\", \"title\": \"096ba1951f5e67dfa4ed270753e29d652bc69fa9\", \"url\": \"https://gnu.googlesource.com/gcc/+/096ba1951f5e67dfa4ed270753e29d652bc69fa9\"}]}, \"$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\": \"096ba1951f5e67dfa4ed270753e29d652bc69fa9,d4c9a4f87ddbbb79d852f59ee1723e03294540c2\", \"instance_id\": \"mftqQF4XneKQYt2p9IdBUqape6n-s1rdp9HnYgUxq5wC\", \"isolated\": \"11b8bbd15a00ecde50fa1f3fb62d9d4e418dd212\", \"mastername\": \"gcc\", \"package\": \"fuchsia/third_party/gcc/mac-amd64\", \"path_config\": \"generic\", \"recipe\": \"gcc_toolchain\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"096ba1951f5e67dfa4ed270753e29d652bc69fa9\"}, \"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\": [\"4838-b69615e\"], \"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": "1582753462564323",
"status": "COMPLETED",
"status_changed_ts": "1582757439646255",
"tags": [
"builder:gcc-x64-mac",
"buildset:commit/git/096ba1951f5e67dfa4ed270753e29d652bc69fa9",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/096ba1951f5e67dfa4ed270753e29d652bc69fa9",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9052786529481637520",
"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/8887356463414491760/+/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:4a9c46275406b610",
"user_agent:luci-scheduler"
],
"updated_ts": "1582757439666386",
"url": "https://ci.chromium.org/b/8887356463414491760",
"utcnow_ts": "1582757440091099"
}
}
[22:50:40.099] Invocation finished in 1h7m2.967635681s with status SUCCEEDED