[06:33:52.239] New invocation is queued and will start shortly
[06:33:53.348] Starting the invocation (attempt 1)
[06:33:53.394] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:33:53.394] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:33:53.394] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9020953633736786960",
"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\":\"d60f79984aecd7f72de6fdf2015100a7516c9ee2\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@d60f79984aecd7f72de6fdf2015100a7516c9ee2\",\"title\":\"d60f79984aecd7f72de6fdf2015100a7516c9ee2\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/d60f79984aecd7f72de6fdf2015100a7516c9ee2\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"95abb3944c6a97aeddfe91ef09405cf0b9e8142b\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@95abb3944c6a97aeddfe91ef09405cf0b9e8142b\",\"title\":\"95abb3944c6a97aeddfe91ef09405cf0b9e8142b\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/95abb3944c6a97aeddfe91ef09405cf0b9e8142b\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"528a4f87c60a239b015847f69a957b6910ab3f22\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@528a4f87c60a239b015847f69a957b6910ab3f22\",\"title\":\"528a4f87c60a239b015847f69a957b6910ab3f22\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/528a4f87c60a239b015847f69a957b6910ab3f22\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"528a4f87c60a239b015847f69a957b6910ab3f22\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-prod-trigger",
"scheduler_invocation_id:9020953633736786960",
"scheduler_job_id:fuchsia/gcc-prod-trigger-3e002780",
"user_agent:luci-scheduler",
"buildset:commit/git/528a4f87c60a239b015847f69a957b6910ab3f22",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/528a4f87c60a239b015847f69a957b6910ab3f22",
"gitiles_ref:refs/heads/master"
]
}
[06:33:54.102] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1613111633594098",
"id": "8855523571650294448",
"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\": \"d60f79984aecd7f72de6fdf2015100a7516c9ee2\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@d60f79984aecd7f72de6fdf2015100a7516c9ee2\", \"title\": \"d60f79984aecd7f72de6fdf2015100a7516c9ee2\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/d60f79984aecd7f72de6fdf2015100a7516c9ee2\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"95abb3944c6a97aeddfe91ef09405cf0b9e8142b\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@95abb3944c6a97aeddfe91ef09405cf0b9e8142b\", \"title\": \"95abb3944c6a97aeddfe91ef09405cf0b9e8142b\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/95abb3944c6a97aeddfe91ef09405cf0b9e8142b\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"528a4f87c60a239b015847f69a957b6910ab3f22\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@528a4f87c60a239b015847f69a957b6910ab3f22\", \"title\": \"528a4f87c60a239b015847f69a957b6910ab3f22\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/528a4f87c60a239b015847f69a957b6910ab3f22\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"528a4f87c60a239b015847f69a957b6910ab3f22\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613111633912726",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/528a4f87c60a239b015847f69a957b6910ab3f22",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/528a4f87c60a239b015847f69a957b6910ab3f22",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020953633736786960",
"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/8855523571650294448/+/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": "1613111633912832",
"url": "https://ci.chromium.org/b/8855523571650294448",
"utcnow_ts": "1613111634090481"
}
}
[06:33:54.102] Task URL: https://ci.chromium.org/b/8855523571650294448
[06:33:54.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:2:0) after 1m0s
[06:34:10.932] Received PubSub notification, asking Buildbucket for the build status
[06:34:11.007] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:54.116] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:2:0)
[06:34:54.116] Timer tick, asking Buildbucket for the build status
[06:34:54.185] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:54.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:4:0) after 1m0s
[06:35:54.242] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:4:0)
[06:35:54.242] Timer tick, asking Buildbucket for the build status
[06:35:54.340] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:54.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:5:0) after 1m0s
[06:36:54.370] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:5:0)
[06:36:54.370] Timer tick, asking Buildbucket for the build status
[06:36:54.449] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:54.449] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:6:0) after 1m0s
[06:37:54.960] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:6:0)
[06:37:54.960] Timer tick, asking Buildbucket for the build status
[06:37:55.062] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:55.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:7:0) after 1m0s
[06:38:55.297] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:7:0)
[06:38:55.297] Timer tick, asking Buildbucket for the build status
[06:38:55.407] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:55.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:8:0) after 1m0s
[06:39:55.633] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:8:0)
[06:39:55.633] Timer tick, asking Buildbucket for the build status
[06:39:55.870] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:55.870] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:9:0) after 1m0s
[06:40:56.020] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:9:0)
[06:40:56.021] Timer tick, asking Buildbucket for the build status
[06:40:56.105] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:56.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:10:0) after 1m0s
[06:41:56.235] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:10:0)
[06:41:56.235] Timer tick, asking Buildbucket for the build status
[06:41:56.306] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:56.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:11:0) after 1m0s
[06:42:56.368] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:11:0)
[06:42:56.368] Timer tick, asking Buildbucket for the build status
[06:42:56.551] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:56.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:12:0) after 1m0s
[06:43:56.667] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:12:0)
[06:43:56.667] Timer tick, asking Buildbucket for the build status
[06:43:56.775] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:56.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:13:0) after 1m0s
[06:44:56.827] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:13:0)
[06:44:56.827] Timer tick, asking Buildbucket for the build status
[06:44:56.961] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:56.961] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:14:0) after 1m0s
[06:45:57.201] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:14:0)
[06:45:57.201] Timer tick, asking Buildbucket for the build status
[06:45:57.293] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:57.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:15:0) after 1m0s
[06:46:57.410] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:15:0)
[06:46:57.410] Timer tick, asking Buildbucket for the build status
[06:46:57.526] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:57.526] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:16:0) after 1m0s
[06:47:58.750] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:16:0)
[06:47:58.750] Timer tick, asking Buildbucket for the build status
[06:47:58.843] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:58.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:17:0) after 1m0s
[06:48:59.004] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:17:0)
[06:48:59.004] Timer tick, asking Buildbucket for the build status
[06:48:59.108] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:59.108] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:18:0) after 1m0s
[06:49:59.414] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:18:0)
[06:49:59.414] Timer tick, asking Buildbucket for the build status
[06:49:59.495] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:59.495] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:19:0) after 1m0s
[06:50:59.732] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:19:0)
[06:50:59.732] Timer tick, asking Buildbucket for the build status
[06:50:59.827] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:59.827] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:20:0) after 1m0s
[06:51:59.849] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:20:0)
[06:51:59.849] Timer tick, asking Buildbucket for the build status
[06:51:59.935] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:59.935] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:21:0) after 1m0s
[06:52:59.962] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:21:0)
[06:52:59.962] Timer tick, asking Buildbucket for the build status
[06:53:00.148] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:00.148] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:22:0) after 1m0s
[06:54:00.168] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:22:0)
[06:54:00.168] Timer tick, asking Buildbucket for the build status
[06:54:00.297] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:00.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:23:0) after 1m0s
[06:55:00.365] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:23:0)
[06:55:00.365] Timer tick, asking Buildbucket for the build status
[06:55:00.458] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:00.458] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:24:0) after 1m0s
[06:56:00.481] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:24:0)
[06:56:00.481] Timer tick, asking Buildbucket for the build status
[06:56:00.566] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:00.566] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:25:0) after 1m0s
[06:57:00.656] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:25:0)
[06:57:00.656] Timer tick, asking Buildbucket for the build status
[06:57:00.750] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:00.750] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:26:0) after 1m0s
[06:58:01.071] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:26:0)
[06:58:01.071] Timer tick, asking Buildbucket for the build status
[06:58:01.491] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:01.491] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:27:0) after 1m0s
[06:59:01.483] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:27:0)
[06:59:01.483] Timer tick, asking Buildbucket for the build status
[06:59:02.085] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:02.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:28:0) after 1m0s
[07:00:02.169] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:28:0)
[07:00:02.169] Timer tick, asking Buildbucket for the build status
[07:00:02.255] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:02.255] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:29:0) after 1m0s
[07:01:02.280] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:29:0)
[07:01:02.280] Timer tick, asking Buildbucket for the build status
[07:01:02.380] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:02.380] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:30:0) after 1m0s
[07:02:02.439] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:30:0)
[07:02:02.439] Timer tick, asking Buildbucket for the build status
[07:02:02.928] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:02.928] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:31:0) after 1m0s
[07:03:02.958] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:31:0)
[07:03:02.958] Timer tick, asking Buildbucket for the build status
[07:03:03.043] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:03.043] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:32:0) after 1m0s
[07:04:03.112] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:32:0)
[07:04:03.112] Timer tick, asking Buildbucket for the build status
[07:04:03.193] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:03.193] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:33:0) after 1m0s
[07:05:03.239] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:33:0)
[07:05:03.239] Timer tick, asking Buildbucket for the build status
[07:05:03.383] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:03.383] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:34:0) after 1m0s
[07:06:03.508] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:34:0)
[07:06:03.508] Timer tick, asking Buildbucket for the build status
[07:06:03.604] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:03.604] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:35:0) after 1m0s
[07:07:03.615] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:35:0)
[07:07:03.615] Timer tick, asking Buildbucket for the build status
[07:07:04.064] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:04.064] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:36:0) after 1m0s
[07:08:04.230] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:36:0)
[07:08:04.230] Timer tick, asking Buildbucket for the build status
[07:08:04.337] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:04.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:37:0) after 1m0s
[07:09:04.342] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:37:0)
[07:09:04.342] Timer tick, asking Buildbucket for the build status
[07:09:04.450] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:04.450] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:38:0) after 1m0s
[07:10:04.481] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:38:0)
[07:10:04.481] Timer tick, asking Buildbucket for the build status
[07:10:04.754] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:04.754] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:39:0) after 1m0s
[07:11:04.848] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:39:0)
[07:11:04.848] Timer tick, asking Buildbucket for the build status
[07:11:04.931] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:04.932] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:40:0) after 1m0s
[07:12:05.044] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:40:0)
[07:12:05.044] Timer tick, asking Buildbucket for the build status
[07:12:05.127] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:05.127] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:41:0) after 1m0s
[07:13:05.153] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:41:0)
[07:13:05.153] Timer tick, asking Buildbucket for the build status
[07:13:05.257] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:05.257] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:42:0) after 1m0s
[07:14:05.283] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:42:0)
[07:14:05.283] Timer tick, asking Buildbucket for the build status
[07:14:05.392] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:05.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:43:0) after 1m0s
[07:15:05.434] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:43:0)
[07:15:05.434] Timer tick, asking Buildbucket for the build status
[07:15:05.874] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:05.874] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:44:0) after 1m0s
[07:16:05.861] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:44:0)
[07:16:05.861] Timer tick, asking Buildbucket for the build status
[07:16:05.958] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:05.958] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:45:0) after 1m0s
[07:17:05.968] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:45:0)
[07:17:05.968] Timer tick, asking Buildbucket for the build status
[07:17:06.179] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:06.179] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:46:0) after 1m0s
[07:18:06.199] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:46:0)
[07:18:06.199] Timer tick, asking Buildbucket for the build status
[07:18:06.489] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:06.489] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:47:0) after 1m0s
[07:19:06.491] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:47:0)
[07:19:06.491] Timer tick, asking Buildbucket for the build status
[07:19:06.588] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:06.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:48:0) after 1m0s
[07:20:06.659] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:48:0)
[07:20:06.659] Timer tick, asking Buildbucket for the build status
[07:20:06.823] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:06.823] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:49:0) after 1m0s
[07:21:07.012] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:49:0)
[07:21:07.012] Timer tick, asking Buildbucket for the build status
[07:21:07.219] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:07.219] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:50:0) after 1m0s
[07:22:07.242] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:50:0)
[07:22:07.242] Timer tick, asking Buildbucket for the build status
[07:22:07.321] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:07.321] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:51:0) after 1m0s
[07:23:07.467] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:51:0)
[07:23:07.467] Timer tick, asking Buildbucket for the build status
[07:23:07.554] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:07.554] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:52:0) after 1m0s
[07:24:07.703] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:52:0)
[07:24:07.703] Timer tick, asking Buildbucket for the build status
[07:24:08.116] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:08.116] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:53:0) after 1m0s
[07:25:08.235] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:53:0)
[07:25:08.235] Timer tick, asking Buildbucket for the build status
[07:25:08.602] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:08.602] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:54:0) after 1m0s
[07:26:08.697] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:54:0)
[07:26:08.697] Timer tick, asking Buildbucket for the build status
[07:26:08.788] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:08.788] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:55:0) after 1m0s
[07:27:08.836] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:55:0)
[07:27:08.836] Timer tick, asking Buildbucket for the build status
[07:27:08.935] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:08.935] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:56:0) after 1m0s
[07:28:08.998] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:56:0)
[07:28:08.998] Timer tick, asking Buildbucket for the build status
[07:28:09.085] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:09.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:57:0) after 1m0s
[07:29:09.118] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:57:0)
[07:29:09.118] Timer tick, asking Buildbucket for the build status
[07:29:09.206] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:09.206] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:58:0) after 1m0s
[07:30:09.218] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:58:0)
[07:30:09.218] Timer tick, asking Buildbucket for the build status
[07:30:09.311] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:09.311] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:59:0) after 1m0s
[07:31:09.393] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:59:0)
[07:31:09.393] Timer tick, asking Buildbucket for the build status
[07:31:09.463] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:09.463] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:60:0) after 1m0s
[07:32:09.447] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:60:0)
[07:32:09.447] Timer tick, asking Buildbucket for the build status
[07:32:09.669] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:09.669] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:61:0) after 1m0s
[07:33:09.754] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:61:0)
[07:33:09.754] Timer tick, asking Buildbucket for the build status
[07:33:10.049] Build 8855523571650294448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:10.049] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9020953633736786960:62:0) after 1m0s
[07:33:33.170] Received PubSub notification, asking Buildbucket for the build status
[07:33:33.247] Build 8855523571650294448: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:33:33.247] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1613115212929897",
"created_by": "project:fuchsia",
"created_ts": "1613111633594098",
"id": "8855523571650294448",
"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\": \"d60f79984aecd7f72de6fdf2015100a7516c9ee2\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@d60f79984aecd7f72de6fdf2015100a7516c9ee2\", \"title\": \"d60f79984aecd7f72de6fdf2015100a7516c9ee2\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/d60f79984aecd7f72de6fdf2015100a7516c9ee2\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"95abb3944c6a97aeddfe91ef09405cf0b9e8142b\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@95abb3944c6a97aeddfe91ef09405cf0b9e8142b\", \"title\": \"95abb3944c6a97aeddfe91ef09405cf0b9e8142b\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/95abb3944c6a97aeddfe91ef09405cf0b9e8142b\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"528a4f87c60a239b015847f69a957b6910ab3f22\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@528a4f87c60a239b015847f69a957b6910ab3f22\", \"title\": \"528a4f87c60a239b015847f69a957b6910ab3f22\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/528a4f87c60a239b015847f69a957b6910ab3f22\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"528a4f87c60a239b015847f69a957b6910ab3f22\"}}",
"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": "1613111650259800",
"status": "COMPLETED",
"status_changed_ts": "1613111650709077",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/528a4f87c60a239b015847f69a957b6910ab3f22",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/528a4f87c60a239b015847f69a957b6910ab3f22",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020953633736786960",
"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/8855523571650294448/+/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:51adc3b1408c6610",
"user_agent:luci-scheduler"
],
"updated_ts": "1613115212974233",
"url": "https://ci.chromium.org/b/8855523571650294448",
"utcnow_ts": "1613115213238600"
}
}
[07:33:33.247] Invocation finished in 59m41.026319911s with status SUCCEEDED