[18:33:29.661] New invocation is queued and will start shortly
[18:33:30.903] Starting the invocation (attempt 1)
[18:33:30.938] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:33:30.938] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:33:30.938] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9020908358924873104",
"parameters_json": "{\"builder_name\":\"gcc-prod-trigger\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"3c1d41015b700c1eca3bb23f52440fa1b1328d9f\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@3c1d41015b700c1eca3bb23f52440fa1b1328d9f\",\"title\":\"3c1d41015b700c1eca3bb23f52440fa1b1328d9f\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/3c1d41015b700c1eca3bb23f52440fa1b1328d9f\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"8f054a7a5a973ffc590e90b8cec3d622a8da6c5c\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@8f054a7a5a973ffc590e90b8cec3d622a8da6c5c\",\"title\":\"8f054a7a5a973ffc590e90b8cec3d622a8da6c5c\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/8f054a7a5a973ffc590e90b8cec3d622a8da6c5c\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"17e04eff810ecf1f8392a995876a98361c565ec7\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@17e04eff810ecf1f8392a995876a98361c565ec7\",\"title\":\"17e04eff810ecf1f8392a995876a98361c565ec7\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/17e04eff810ecf1f8392a995876a98361c565ec7\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"96df3e28b835ccb5804bcca96f417761e5e8be67\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@96df3e28b835ccb5804bcca96f417761e5e8be67\",\"title\":\"96df3e28b835ccb5804bcca96f417761e5e8be67\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/96df3e28b835ccb5804bcca96f417761e5e8be67\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"c46b706620eb9b27fa06e26406ffa4f79d9292e6\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@c46b706620eb9b27fa06e26406ffa4f79d9292e6\",\"title\":\"c46b706620eb9b27fa06e26406ffa4f79d9292e6\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/c46b706620eb9b27fa06e26406ffa4f79d9292e6\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"c054dcd552c6ef094376d820b42d0cc6ab717e43\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@c054dcd552c6ef094376d820b42d0cc6ab717e43\",\"title\":\"c054dcd552c6ef094376d820b42d0cc6ab717e43\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/c054dcd552c6ef094376d820b42d0cc6ab717e43\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"c054dcd552c6ef094376d820b42d0cc6ab717e43\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-prod-trigger",
"scheduler_invocation_id:9020908358924873104",
"scheduler_job_id:fuchsia/gcc-prod-trigger-3e002780",
"user_agent:luci-scheduler",
"buildset:commit/git/c054dcd552c6ef094376d820b42d0cc6ab717e43",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/c054dcd552c6ef094376d820b42d0cc6ab717e43",
"gitiles_ref:refs/heads/master"
]
}
[18:33:31.764] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:fuchsia",
"created_ts": "1613154811033162",
"id": "8855478296824956560",
"parameters_json": "{\"builder_name\": \"gcc-prod-trigger\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"3c1d41015b700c1eca3bb23f52440fa1b1328d9f\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@3c1d41015b700c1eca3bb23f52440fa1b1328d9f\", \"title\": \"3c1d41015b700c1eca3bb23f52440fa1b1328d9f\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/3c1d41015b700c1eca3bb23f52440fa1b1328d9f\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"8f054a7a5a973ffc590e90b8cec3d622a8da6c5c\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@8f054a7a5a973ffc590e90b8cec3d622a8da6c5c\", \"title\": \"8f054a7a5a973ffc590e90b8cec3d622a8da6c5c\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/8f054a7a5a973ffc590e90b8cec3d622a8da6c5c\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"17e04eff810ecf1f8392a995876a98361c565ec7\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@17e04eff810ecf1f8392a995876a98361c565ec7\", \"title\": \"17e04eff810ecf1f8392a995876a98361c565ec7\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/17e04eff810ecf1f8392a995876a98361c565ec7\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"96df3e28b835ccb5804bcca96f417761e5e8be67\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@96df3e28b835ccb5804bcca96f417761e5e8be67\", \"title\": \"96df3e28b835ccb5804bcca96f417761e5e8be67\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/96df3e28b835ccb5804bcca96f417761e5e8be67\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"c46b706620eb9b27fa06e26406ffa4f79d9292e6\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@c46b706620eb9b27fa06e26406ffa4f79d9292e6\", \"title\": \"c46b706620eb9b27fa06e26406ffa4f79d9292e6\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/c46b706620eb9b27fa06e26406ffa4f79d9292e6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"c054dcd552c6ef094376d820b42d0cc6ab717e43\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@c054dcd552c6ef094376d820b42d0cc6ab717e43\", \"title\": \"c054dcd552c6ef094376d820b42d0cc6ab717e43\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/c054dcd552c6ef094376d820b42d0cc6ab717e43\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"c054dcd552c6ef094376d820b42d0cc6ab717e43\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613154811592016",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/c054dcd552c6ef094376d820b42d0cc6ab717e43",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/c054dcd552c6ef094376d820b42d0cc6ab717e43",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020908358924873104",
"scheduler_job_id:fuchsia/gcc-prod-trigger-3e002780",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/fuchsia/buildbucket/cr-buildbucket.appspot.com/8855478296824956560/+/annotations",
"swarming_tag:luci_project:fuchsia",
"swarming_tag:recipe_name:toolchain_trigger",
"swarming_tag:recipe_package:fuchsia/infra/recipe_bundles/fuchsia.googlesource.com/infra/recipes",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1613154811592200",
"url": "https://ci.chromium.org/b/8855478296824956560",
"utcnow_ts": "1613154811754632"
}
}
[18:33:31.764] Task URL: https://ci.chromium.org/b/8855478296824956560
[18:33:31.764] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:2:0) after 1m0s
[18:33:46.466] Received PubSub notification, asking Buildbucket for the build status
[18:33:46.558] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:31.793] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:2:0)
[18:34:31.793] Timer tick, asking Buildbucket for the build status
[18:34:31.884] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:31.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:4:0) after 1m0s
[18:35:31.981] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:4:0)
[18:35:31.981] Timer tick, asking Buildbucket for the build status
[18:35:32.222] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:32.222] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:5:0) after 1m0s
[18:36:32.300] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:5:0)
[18:36:32.300] Timer tick, asking Buildbucket for the build status
[18:36:32.442] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:32.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:6:0) after 1m0s
[18:37:32.508] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:6:0)
[18:37:32.508] Timer tick, asking Buildbucket for the build status
[18:37:32.655] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:32.655] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:7:0) after 1m0s
[18:38:32.721] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:7:0)
[18:38:32.721] Timer tick, asking Buildbucket for the build status
[18:38:32.812] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:32.812] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:8:0) after 1m0s
[18:39:32.854] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:8:0)
[18:39:32.854] Timer tick, asking Buildbucket for the build status
[18:39:32.991] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:32.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:9:0) after 1m0s
[18:40:33.007] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:9:0)
[18:40:33.007] Timer tick, asking Buildbucket for the build status
[18:40:33.216] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:33.216] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:10:0) after 1m0s
[18:41:33.218] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:10:0)
[18:41:33.218] Timer tick, asking Buildbucket for the build status
[18:41:33.322] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:33.322] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:11:0) after 1m0s
[18:42:33.327] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:11:0)
[18:42:33.327] Timer tick, asking Buildbucket for the build status
[18:42:33.609] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:33.609] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:12:0) after 1m0s
[18:43:33.633] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:12:0)
[18:43:33.633] Timer tick, asking Buildbucket for the build status
[18:43:33.762] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:33.762] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:13:0) after 1m0s
[18:44:33.809] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:13:0)
[18:44:33.809] Timer tick, asking Buildbucket for the build status
[18:44:33.908] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:33.908] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:14:0) after 1m0s
[18:45:33.911] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:14:0)
[18:45:33.911] Timer tick, asking Buildbucket for the build status
[18:45:34.006] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:34.006] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:15:0) after 1m0s
[18:46:34.046] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:15:0)
[18:46:34.046] Timer tick, asking Buildbucket for the build status
[18:46:34.131] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:34.131] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:16:0) after 1m0s
[18:47:34.153] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:16:0)
[18:47:34.153] Timer tick, asking Buildbucket for the build status
[18:47:34.288] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:34.289] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:17:0) after 1m0s
[18:48:34.373] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:17:0)
[18:48:34.373] Timer tick, asking Buildbucket for the build status
[18:48:34.504] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:34.504] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:18:0) after 1m0s
[18:49:34.503] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:18:0)
[18:49:34.503] Timer tick, asking Buildbucket for the build status
[18:49:34.603] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:34.603] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:19:0) after 1m0s
[18:50:34.921] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:19:0)
[18:50:34.921] Timer tick, asking Buildbucket for the build status
[18:50:35.227] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:35.227] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:20:0) after 1m0s
[18:51:35.255] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:20:0)
[18:51:35.255] Timer tick, asking Buildbucket for the build status
[18:51:35.461] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:35.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:21:0) after 1m0s
[18:52:35.506] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:21:0)
[18:52:35.506] Timer tick, asking Buildbucket for the build status
[18:52:35.626] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:35.626] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:22:0) after 1m0s
[18:53:35.648] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:22:0)
[18:53:35.648] Timer tick, asking Buildbucket for the build status
[18:53:36.093] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:36.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:23:0) after 1m0s
[18:54:36.142] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:23:0)
[18:54:36.142] Timer tick, asking Buildbucket for the build status
[18:54:36.340] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:36.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:24:0) after 1m0s
[18:55:36.420] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:24:0)
[18:55:36.420] Timer tick, asking Buildbucket for the build status
[18:55:36.510] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:36.510] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:25:0) after 1m0s
[18:56:36.490] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:25:0)
[18:56:36.490] Timer tick, asking Buildbucket for the build status
[18:56:36.561] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:36.561] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:26:0) after 1m0s
[18:57:36.583] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:26:0)
[18:57:36.583] Timer tick, asking Buildbucket for the build status
[18:57:36.875] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:36.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:27:0) after 1m0s
[18:58:36.881] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:27:0)
[18:58:36.881] Timer tick, asking Buildbucket for the build status
[18:58:36.976] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:36.976] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:28:0) after 1m0s
[18:59:37.028] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:28:0)
[18:59:37.028] Timer tick, asking Buildbucket for the build status
[18:59:37.114] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:37.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:29:0) after 1m0s
[19:00:37.119] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:29:0)
[19:00:37.119] Timer tick, asking Buildbucket for the build status
[19:00:37.207] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:37.207] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:30:0) after 1m0s
[19:01:37.226] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:30:0)
[19:01:37.226] Timer tick, asking Buildbucket for the build status
[19:01:37.478] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:37.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:31:0) after 1m0s
[19:02:37.496] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:31:0)
[19:02:37.496] Timer tick, asking Buildbucket for the build status
[19:02:37.601] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:37.601] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:32:0) after 1m0s
[19:03:37.627] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:32:0)
[19:03:37.627] Timer tick, asking Buildbucket for the build status
[19:03:37.726] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:37.726] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:33:0) after 1m0s
[19:04:37.749] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:33:0)
[19:04:37.749] Timer tick, asking Buildbucket for the build status
[19:04:38.035] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:38.035] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:34:0) after 1m0s
[19:05:38.053] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:34:0)
[19:05:38.053] Timer tick, asking Buildbucket for the build status
[19:05:38.329] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:38.329] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:35:0) after 1m0s
[19:06:38.370] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:35:0)
[19:06:38.370] Timer tick, asking Buildbucket for the build status
[19:06:38.466] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:38.466] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:36:0) after 1m0s
[19:07:38.505] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:36:0)
[19:07:38.505] Timer tick, asking Buildbucket for the build status
[19:07:38.620] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:38.620] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:37:0) after 1m0s
[19:08:38.662] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:37:0)
[19:08:38.662] Timer tick, asking Buildbucket for the build status
[19:08:38.915] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:38.915] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:38:0) after 1m0s
[19:09:38.936] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:38:0)
[19:09:38.936] Timer tick, asking Buildbucket for the build status
[19:09:39.014] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:39.014] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:39:0) after 1m0s
[19:10:39.044] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:39:0)
[19:10:39.044] Timer tick, asking Buildbucket for the build status
[19:10:39.137] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:39.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:40:0) after 1m0s
[19:11:39.157] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:40:0)
[19:11:39.157] Timer tick, asking Buildbucket for the build status
[19:11:39.386] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:39.386] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:41:0) after 1m0s
[19:12:39.408] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:41:0)
[19:12:39.408] Timer tick, asking Buildbucket for the build status
[19:12:39.541] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:39.541] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:42:0) after 1m0s
[19:13:39.585] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:42:0)
[19:13:39.585] Timer tick, asking Buildbucket for the build status
[19:13:40.053] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:40.053] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:43:0) after 1m0s
[19:14:40.073] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:43:0)
[19:14:40.073] Timer tick, asking Buildbucket for the build status
[19:14:40.337] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:40.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:44:0) after 1m0s
[19:15:40.357] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:44:0)
[19:15:40.357] Timer tick, asking Buildbucket for the build status
[19:15:40.464] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:40.464] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:45:0) after 1m0s
[19:16:40.451] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:45:0)
[19:16:40.451] Timer tick, asking Buildbucket for the build status
[19:16:40.575] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:40.575] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:46:0) after 1m0s
[19:17:40.606] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:46:0)
[19:17:40.606] Timer tick, asking Buildbucket for the build status
[19:17:40.796] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:40.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:47:0) after 1m0s
[19:18:40.804] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:47:0)
[19:18:40.804] Timer tick, asking Buildbucket for the build status
[19:18:40.948] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:40.948] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:48:0) after 1m0s
[19:19:40.968] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:48:0)
[19:19:40.968] Timer tick, asking Buildbucket for the build status
[19:19:41.078] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:41.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:49:0) after 1m0s
[19:20:41.101] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:49:0)
[19:20:41.101] Timer tick, asking Buildbucket for the build status
[19:20:41.215] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:41.215] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:50:0) after 1m0s
[19:21:41.277] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:50:0)
[19:21:41.277] Timer tick, asking Buildbucket for the build status
[19:21:41.389] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:41.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:51:0) after 1m0s
[19:22:41.458] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:51:0)
[19:22:41.458] Timer tick, asking Buildbucket for the build status
[19:22:41.537] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:41.537] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:52:0) after 1m0s
[19:23:41.605] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:52:0)
[19:23:41.605] Timer tick, asking Buildbucket for the build status
[19:23:41.730] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:41.730] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:53:0) after 1m0s
[19:24:41.754] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:53:0)
[19:24:41.754] Timer tick, asking Buildbucket for the build status
[19:24:41.842] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:41.842] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:54:0) after 1m0s
[19:25:41.887] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:54:0)
[19:25:41.887] Timer tick, asking Buildbucket for the build status
[19:25:41.976] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:41.976] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:55:0) after 1m0s
[19:26:42.057] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:55:0)
[19:26:42.057] Timer tick, asking Buildbucket for the build status
[19:26:42.172] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:42.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:56:0) after 1m0s
[19:27:42.201] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:56:0)
[19:27:42.201] Timer tick, asking Buildbucket for the build status
[19:27:42.411] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:42.411] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:57:0) after 1m0s
[19:28:42.465] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:57:0)
[19:28:42.465] Timer tick, asking Buildbucket for the build status
[19:28:42.725] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:42.725] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:58:0) after 1m0s
[19:29:42.795] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:58:0)
[19:29:42.796] Timer tick, asking Buildbucket for the build status
[19:29:43.405] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:43.405] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:59:0) after 1m0s
[19:30:44.326] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:59:0)
[19:30:44.326] Timer tick, asking Buildbucket for the build status
[19:30:44.406] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:44.406] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:60:0) after 1m0s
[19:31:44.761] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:60:0)
[19:31:44.761] Timer tick, asking Buildbucket for the build status
[19:31:44.982] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:44.982] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:61:0) after 1m0s
[19:32:45.059] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:61:0)
[19:32:45.059] Timer tick, asking Buildbucket for the build status
[19:32:45.163] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:45.163] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:62:0) after 1m0s
[19:33:45.268] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:62:0)
[19:33:45.268] Timer tick, asking Buildbucket for the build status
[19:33:45.415] Build 8855478296824956560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:45.415] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020908358924873104:63:0) after 1m0s
[19:34:10.651] Received PubSub notification, asking Buildbucket for the build status
[19:34:11.086] Build 8855478296824956560: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:34:11.086] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1613158450095967",
"created_by": "project:fuchsia",
"created_ts": "1613154811033162",
"id": "8855478296824956560",
"parameters_json": "{\"builder_name\": \"gcc-prod-trigger\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"3c1d41015b700c1eca3bb23f52440fa1b1328d9f\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@3c1d41015b700c1eca3bb23f52440fa1b1328d9f\", \"title\": \"3c1d41015b700c1eca3bb23f52440fa1b1328d9f\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/3c1d41015b700c1eca3bb23f52440fa1b1328d9f\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"8f054a7a5a973ffc590e90b8cec3d622a8da6c5c\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@8f054a7a5a973ffc590e90b8cec3d622a8da6c5c\", \"title\": \"8f054a7a5a973ffc590e90b8cec3d622a8da6c5c\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/8f054a7a5a973ffc590e90b8cec3d622a8da6c5c\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"17e04eff810ecf1f8392a995876a98361c565ec7\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@17e04eff810ecf1f8392a995876a98361c565ec7\", \"title\": \"17e04eff810ecf1f8392a995876a98361c565ec7\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/17e04eff810ecf1f8392a995876a98361c565ec7\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"96df3e28b835ccb5804bcca96f417761e5e8be67\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@96df3e28b835ccb5804bcca96f417761e5e8be67\", \"title\": \"96df3e28b835ccb5804bcca96f417761e5e8be67\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/96df3e28b835ccb5804bcca96f417761e5e8be67\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"c46b706620eb9b27fa06e26406ffa4f79d9292e6\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@c46b706620eb9b27fa06e26406ffa4f79d9292e6\", \"title\": \"c46b706620eb9b27fa06e26406ffa4f79d9292e6\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/c46b706620eb9b27fa06e26406ffa4f79d9292e6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"c054dcd552c6ef094376d820b42d0cc6ab717e43\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@c054dcd552c6ef094376d820b42d0cc6ab717e43\", \"title\": \"c054dcd552c6ef094376d820b42d0cc6ab717e43\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/c054dcd552c6ef094376d820b42d0cc6ab717e43\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"c054dcd552c6ef094376d820b42d0cc6ab717e43\"}}",
"project": "fuchsia",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder\", \"git\", \"goma_v2\", \"symbol\", \"vpython\"], \"cores\": [\"2\"], \"cpu\": [\"x64\", \"x86\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"fuchsia-infra\"], \"gpu\": [\"none\"], \"id\": [\"fuchsia-prod-e2-2-ssd0-us-central1-a-0-qod1\"], \"image\": [\"fuchsia-debian-9-v20210121-f1877f1\"], \"inside_docker\": [\"0\"], \"kvm\": [\"0\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-2\"], \"os\": [\"Debian\", \"Debian-9\", \"Debian-9.13\", \"Linux\"], \"pool\": [\"luci.fuchsia.prod\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5690-40331dd\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1613154825534851",
"status": "COMPLETED",
"status_changed_ts": "1613154826013373",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/c054dcd552c6ef094376d820b42d0cc6ab717e43",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/c054dcd552c6ef094376d820b42d0cc6ab717e43",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020908358924873104",
"scheduler_job_id:fuchsia/gcc-prod-trigger-3e002780",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/fuchsia/buildbucket/cr-buildbucket.appspot.com/8855478296824956560/+/annotations",
"swarming_tag:luci_project:fuchsia",
"swarming_tag:os:Debian",
"swarming_tag:recipe_name:toolchain_trigger",
"swarming_tag:recipe_package:fuchsia/infra/recipe_bundles/fuchsia.googlesource.com/infra/recipes",
"swarming_task_id:51b0568998893710",
"user_agent:luci-scheduler"
],
"updated_ts": "1613158450225275",
"url": "https://ci.chromium.org/b/8855478296824956560",
"utcnow_ts": "1613158451074458"
}
}
[19:34:11.086] Invocation finished in 1h0m41.439893482s with status SUCCEEDED