[18:34:17.007] New invocation is queued and will start shortly
[18:34:18.139] Starting the invocation (attempt 1)
[18:34:18.181] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:34:18.181] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:34:18.182] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9032414124048064192",
"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\":\"f9ff65d4dffbaf342dce7a8760059c27683cd962\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f9ff65d4dffbaf342dce7a8760059c27683cd962\",\"title\":\"f9ff65d4dffbaf342dce7a8760059c27683cd962\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/f9ff65d4dffbaf342dce7a8760059c27683cd962\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"51a948fdf0e14fb69ab9e0c79ae8b2415801f9a3\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@51a948fdf0e14fb69ab9e0c79ae8b2415801f9a3\",\"title\":\"51a948fdf0e14fb69ab9e0c79ae8b2415801f9a3\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/51a948fdf0e14fb69ab9e0c79ae8b2415801f9a3\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"f511427204f281bc6278bb1facf6493518300806\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f511427204f281bc6278bb1facf6493518300806\",\"title\":\"f511427204f281bc6278bb1facf6493518300806\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/f511427204f281bc6278bb1facf6493518300806\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"f511427204f281bc6278bb1facf6493518300806\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-prod-trigger",
"scheduler_invocation_id:9032414124048064192",
"scheduler_job_id:fuchsia/gcc-prod-trigger-3e002780",
"user_agent:luci-scheduler",
"buildset:commit/git/f511427204f281bc6278bb1facf6493518300806",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/f511427204f281bc6278bb1facf6493518300806",
"gitiles_ref:refs/heads/master"
]
}
[18:34:18.864] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1602182058271171",
"id": "8866984062024986224",
"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\": \"f9ff65d4dffbaf342dce7a8760059c27683cd962\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f9ff65d4dffbaf342dce7a8760059c27683cd962\", \"title\": \"f9ff65d4dffbaf342dce7a8760059c27683cd962\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/f9ff65d4dffbaf342dce7a8760059c27683cd962\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"51a948fdf0e14fb69ab9e0c79ae8b2415801f9a3\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@51a948fdf0e14fb69ab9e0c79ae8b2415801f9a3\", \"title\": \"51a948fdf0e14fb69ab9e0c79ae8b2415801f9a3\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/51a948fdf0e14fb69ab9e0c79ae8b2415801f9a3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"f511427204f281bc6278bb1facf6493518300806\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f511427204f281bc6278bb1facf6493518300806\", \"title\": \"f511427204f281bc6278bb1facf6493518300806\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/f511427204f281bc6278bb1facf6493518300806\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"f511427204f281bc6278bb1facf6493518300806\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602182058732014",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/f511427204f281bc6278bb1facf6493518300806",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/f511427204f281bc6278bb1facf6493518300806",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032414124048064192",
"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/8866984062024986224/+/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": "1602182058732121",
"url": "https://ci.chromium.org/b/8866984062024986224",
"utcnow_ts": "1602182058856701"
}
}
[18:34:18.864] Task URL: https://ci.chromium.org/b/8866984062024986224
[18:34:18.864] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:2:0) after 1m0s
[18:34:25.771] Received PubSub notification, asking Buildbucket for the build status
[18:34:25.861] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:18.939] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:2:0)
[18:35:18.939] Timer tick, asking Buildbucket for the build status
[18:35:19.278] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:19.278] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:4:0) after 1m0s
[18:36:19.291] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:4:0)
[18:36:19.291] Timer tick, asking Buildbucket for the build status
[18:36:19.719] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:19.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:5:0) after 1m0s
[18:37:19.842] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:5:0)
[18:37:19.842] Timer tick, asking Buildbucket for the build status
[18:37:19.920] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:19.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:6:0) after 1m0s
[18:38:20.183] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:6:0)
[18:38:20.183] Timer tick, asking Buildbucket for the build status
[18:38:20.235] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:20.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:7:0) after 1m0s
[18:39:20.236] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:7:0)
[18:39:20.236] Timer tick, asking Buildbucket for the build status
[18:39:20.361] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:20.361] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:8:0) after 1m0s
[18:40:20.455] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:8:0)
[18:40:20.455] Timer tick, asking Buildbucket for the build status
[18:40:20.530] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:20.530] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:9:0) after 1m0s
[18:41:22.369] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:9:0)
[18:41:22.369] Timer tick, asking Buildbucket for the build status
[18:41:24.086] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:24.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:10:0) after 1m0s
[18:42:24.094] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:10:0)
[18:42:24.094] Timer tick, asking Buildbucket for the build status
[18:42:24.845] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:24.845] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:11:0) after 1m0s
[18:43:24.996] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:11:0)
[18:43:24.996] Timer tick, asking Buildbucket for the build status
[18:43:25.052] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:25.052] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:12:0) after 1m0s
[18:44:25.098] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:12:0)
[18:44:25.098] Timer tick, asking Buildbucket for the build status
[18:44:25.221] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:25.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:13:0) after 1m0s
[18:45:25.389] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:13:0)
[18:45:25.389] Timer tick, asking Buildbucket for the build status
[18:45:25.467] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:25.467] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:14:0) after 1m0s
[18:46:25.537] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:14:0)
[18:46:25.537] Timer tick, asking Buildbucket for the build status
[18:46:25.615] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:25.615] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:15:0) after 1m0s
[18:47:25.738] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:15:0)
[18:47:25.738] Timer tick, asking Buildbucket for the build status
[18:47:25.821] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:25.821] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:16:0) after 1m0s
[18:48:25.914] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:16:0)
[18:48:25.914] Timer tick, asking Buildbucket for the build status
[18:48:25.981] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:25.981] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:17:0) after 1m0s
[18:49:25.968] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:17:0)
[18:49:25.968] Timer tick, asking Buildbucket for the build status
[18:49:26.084] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:26.084] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:18:0) after 1m0s
[18:50:26.107] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:18:0)
[18:50:26.107] Timer tick, asking Buildbucket for the build status
[18:50:26.211] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:26.211] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:19:0) after 1m0s
[18:51:26.272] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:19:0)
[18:51:26.272] Timer tick, asking Buildbucket for the build status
[18:51:26.390] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:26.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:20:0) after 1m0s
[18:52:26.426] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:20:0)
[18:52:26.426] Timer tick, asking Buildbucket for the build status
[18:52:26.487] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:26.487] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:21:0) after 1m0s
[18:53:26.527] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:21:0)
[18:53:26.527] Timer tick, asking Buildbucket for the build status
[18:53:26.595] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:26.595] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:22:0) after 1m0s
[18:54:26.616] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:22:0)
[18:54:26.616] Timer tick, asking Buildbucket for the build status
[18:54:26.791] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:26.791] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:23:0) after 1m0s
[18:55:26.829] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:23:0)
[18:55:26.829] Timer tick, asking Buildbucket for the build status
[18:55:26.926] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:26.926] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:24:0) after 1m0s
[18:56:26.923] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:24:0)
[18:56:26.923] Timer tick, asking Buildbucket for the build status
[18:56:26.997] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:26.997] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:25:0) after 1m0s
[18:57:27.107] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:25:0)
[18:57:27.107] Timer tick, asking Buildbucket for the build status
[18:57:27.166] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:27.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:26:0) after 1m0s
[18:58:27.215] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:26:0)
[18:58:27.215] Timer tick, asking Buildbucket for the build status
[18:58:27.286] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:27.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:27:0) after 1m0s
[18:59:27.308] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:27:0)
[18:59:27.308] Timer tick, asking Buildbucket for the build status
[18:59:27.482] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:27.482] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:28:0) after 1m0s
[19:00:27.511] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:28:0)
[19:00:27.512] Timer tick, asking Buildbucket for the build status
[19:00:27.827] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:27.827] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:29:0) after 1m0s
[19:01:27.816] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:29:0)
[19:01:27.816] Timer tick, asking Buildbucket for the build status
[19:01:28.124] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:28.124] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:30:0) after 1m0s
[19:02:28.128] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:30:0)
[19:02:28.128] Timer tick, asking Buildbucket for the build status
[19:02:28.519] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:28.519] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:31:0) after 1m0s
[19:03:28.529] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:31:0)
[19:03:28.529] Timer tick, asking Buildbucket for the build status
[19:03:28.618] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:28.618] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:32:0) after 1m0s
[19:04:28.642] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:32:0)
[19:04:28.642] Timer tick, asking Buildbucket for the build status
[19:04:28.795] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:28.795] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:33:0) after 1m0s
[19:05:28.844] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:33:0)
[19:05:28.844] Timer tick, asking Buildbucket for the build status
[19:05:28.940] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:28.940] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:34:0) after 1m0s
[19:06:28.952] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:34:0)
[19:06:28.952] Timer tick, asking Buildbucket for the build status
[19:06:29.032] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:29.032] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:35:0) after 1m0s
[19:07:29.105] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:35:0)
[19:07:29.105] Timer tick, asking Buildbucket for the build status
[19:07:29.254] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:29.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:36:0) after 1m0s
[19:08:29.354] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:36:0)
[19:08:29.354] Timer tick, asking Buildbucket for the build status
[19:08:29.856] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:29.856] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:37:0) after 1m0s
[19:09:30.003] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:37:0)
[19:09:30.003] Timer tick, asking Buildbucket for the build status
[19:09:30.137] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:30.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:38:0) after 1m0s
[19:10:30.185] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:38:0)
[19:10:30.185] Timer tick, asking Buildbucket for the build status
[19:10:30.309] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:30.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:39:0) after 1m0s
[19:11:30.291] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:39:0)
[19:11:30.291] Timer tick, asking Buildbucket for the build status
[19:11:30.360] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:30.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:40:0) after 1m0s
[19:12:30.376] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:40:0)
[19:12:30.376] Timer tick, asking Buildbucket for the build status
[19:12:30.449] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:30.449] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:41:0) after 1m0s
[19:13:30.554] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:41:0)
[19:13:30.554] Timer tick, asking Buildbucket for the build status
[19:13:30.739] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:30.739] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:42:0) after 1m0s
[19:14:30.772] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:42:0)
[19:14:30.772] Timer tick, asking Buildbucket for the build status
[19:14:30.896] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:30.896] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:43:0) after 1m0s
[19:15:30.974] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:43:0)
[19:15:30.974] Timer tick, asking Buildbucket for the build status
[19:15:31.194] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:31.194] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:44:0) after 1m0s
[19:16:31.596] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:44:0)
[19:16:31.596] Timer tick, asking Buildbucket for the build status
[19:16:31.705] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:31.705] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:45:0) after 1m0s
[19:17:32.195] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:45:0)
[19:17:32.195] Timer tick, asking Buildbucket for the build status
[19:17:32.253] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:32.253] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:46:0) after 1m0s
[19:18:32.643] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:46:0)
[19:18:32.643] Timer tick, asking Buildbucket for the build status
[19:18:32.714] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:32.714] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:47:0) after 1m0s
[19:19:32.870] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:47:0)
[19:19:32.870] Timer tick, asking Buildbucket for the build status
[19:19:33.291] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:33.291] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:48:0) after 1m0s
[19:20:33.389] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:48:0)
[19:20:33.389] Timer tick, asking Buildbucket for the build status
[19:20:33.586] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:33.586] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:49:0) after 1m0s
[19:21:33.825] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:49:0)
[19:21:33.825] Timer tick, asking Buildbucket for the build status
[19:21:33.904] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:33.904] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:50:0) after 1m0s
[19:22:34.060] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:50:0)
[19:22:34.060] Timer tick, asking Buildbucket for the build status
[19:22:34.154] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:34.154] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:51:0) after 1m0s
[19:23:34.214] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:51:0)
[19:23:34.214] Timer tick, asking Buildbucket for the build status
[19:23:34.315] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:34.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:52:0) after 1m0s
[19:24:34.429] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:52:0)
[19:24:34.429] Timer tick, asking Buildbucket for the build status
[19:24:34.554] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:34.554] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:53:0) after 1m0s
[19:25:34.691] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:53:0)
[19:25:34.691] Timer tick, asking Buildbucket for the build status
[19:25:34.755] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:34.755] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:54:0) after 1m0s
[19:26:34.931] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:54:0)
[19:26:34.931] Timer tick, asking Buildbucket for the build status
[19:26:35.023] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:35.023] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:55:0) after 1m0s
[19:27:36.475] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:55:0)
[19:27:36.475] Timer tick, asking Buildbucket for the build status
[19:27:36.560] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:36.560] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:56:0) after 1m0s
[19:28:36.685] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:56:0)
[19:28:36.685] Timer tick, asking Buildbucket for the build status
[19:28:36.785] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:36.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:57:0) after 1m0s
[19:29:39.106] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:57:0)
[19:29:39.106] Timer tick, asking Buildbucket for the build status
[19:29:39.214] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:39.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:58:0) after 1m0s
[19:30:39.261] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:58:0)
[19:30:39.261] Timer tick, asking Buildbucket for the build status
[19:30:39.315] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:39.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:59:0) after 1m0s
[19:31:39.363] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:59:0)
[19:31:39.363] Timer tick, asking Buildbucket for the build status
[19:31:39.432] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:39.432] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:60:0) after 1m0s
[19:32:39.466] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:60:0)
[19:32:39.466] Timer tick, asking Buildbucket for the build status
[19:32:39.622] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:39.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:61:0) after 1m0s
[19:33:39.651] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:61:0)
[19:33:39.651] Timer tick, asking Buildbucket for the build status
[19:33:39.913] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:39.913] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:62:0) after 1m0s
[19:34:39.941] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:62:0)
[19:34:39.941] Timer tick, asking Buildbucket for the build status
[19:34:40.055] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:40.055] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:63:0) after 1m0s
[19:35:40.106] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:63:0)
[19:35:40.106] Timer tick, asking Buildbucket for the build status
[19:35:40.179] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:40.179] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:64:0) after 1m0s
[19:36:40.227] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:64:0)
[19:36:40.227] Timer tick, asking Buildbucket for the build status
[19:36:40.306] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:40.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:65:0) after 1m0s
[19:37:40.333] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:65:0)
[19:37:40.333] Timer tick, asking Buildbucket for the build status
[19:37:40.529] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:40.529] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:66:0) after 1m0s
[19:38:41.104] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:66:0)
[19:38:41.104] Timer tick, asking Buildbucket for the build status
[19:38:41.218] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:41.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:67:0) after 1m0s
[19:39:41.335] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:67:0)
[19:39:41.335] Timer tick, asking Buildbucket for the build status
[19:39:41.523] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:41.523] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:68:0) after 1m0s
[19:40:41.564] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:68:0)
[19:40:41.564] Timer tick, asking Buildbucket for the build status
[19:40:42.007] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:42.007] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:69:0) after 1m0s
[19:41:42.025] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:69:0)
[19:41:42.025] Timer tick, asking Buildbucket for the build status
[19:41:42.114] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:42.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:70:0) after 1m0s
[19:42:42.212] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:70:0)
[19:42:42.212] Timer tick, asking Buildbucket for the build status
[19:42:42.294] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:42.294] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:71:0) after 1m0s
[19:43:42.386] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:71:0)
[19:43:42.386] Timer tick, asking Buildbucket for the build status
[19:43:42.668] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:42.668] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:72:0) after 1m0s
[19:44:42.692] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:72:0)
[19:44:42.692] Timer tick, asking Buildbucket for the build status
[19:44:43.303] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:43.303] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:73:0) after 1m0s
[19:45:43.368] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:73:0)
[19:45:43.368] Timer tick, asking Buildbucket for the build status
[19:45:43.464] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:43.464] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:74:0) after 1m0s
[19:46:43.508] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:74:0)
[19:46:43.508] Timer tick, asking Buildbucket for the build status
[19:46:43.591] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:43.591] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:75:0) after 1m0s
[19:47:43.654] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:75:0)
[19:47:43.654] Timer tick, asking Buildbucket for the build status
[19:47:43.739] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:43.739] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:76:0) after 1m0s
[19:48:43.850] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:76:0)
[19:48:43.850] Timer tick, asking Buildbucket for the build status
[19:48:43.944] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:43.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:77:0) after 1m0s
[19:49:43.985] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:77:0)
[19:49:43.985] Timer tick, asking Buildbucket for the build status
[19:49:44.502] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:44.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:78:0) after 1m0s
[19:50:44.578] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:78:0)
[19:50:44.578] Timer tick, asking Buildbucket for the build status
[19:50:45.002] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:45.002] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:79:0) after 1m0s
[19:51:45.046] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:79:0)
[19:51:45.046] Timer tick, asking Buildbucket for the build status
[19:51:45.224] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:45.224] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:80:0) after 1m0s
[19:52:45.368] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:80:0)
[19:52:45.368] Timer tick, asking Buildbucket for the build status
[19:52:45.500] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:45.500] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:81:0) after 1m0s
[19:53:45.595] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:81:0)
[19:53:45.595] Timer tick, asking Buildbucket for the build status
[19:53:45.657] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:45.657] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:82:0) after 1m0s
[19:54:45.735] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:82:0)
[19:54:45.735] Timer tick, asking Buildbucket for the build status
[19:54:45.847] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:45.847] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:83:0) after 1m0s
[19:55:45.867] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:83:0)
[19:55:45.867] Timer tick, asking Buildbucket for the build status
[19:55:46.055] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:46.055] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:84:0) after 1m0s
[19:56:46.151] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:84:0)
[19:56:46.151] Timer tick, asking Buildbucket for the build status
[19:56:46.229] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:46.229] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:85:0) after 1m0s
[19:57:46.332] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:85:0)
[19:57:46.332] Timer tick, asking Buildbucket for the build status
[19:57:46.418] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:46.418] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:86:0) after 1m0s
[19:58:46.501] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:86:0)
[19:58:46.501] Timer tick, asking Buildbucket for the build status
[19:58:46.584] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:46.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:87:0) after 1m0s
[19:59:46.694] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:87:0)
[19:59:46.694] Timer tick, asking Buildbucket for the build status
[19:59:46.786] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:46.786] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:88:0) after 1m0s
[20:00:46.934] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:88:0)
[20:00:46.934] Timer tick, asking Buildbucket for the build status
[20:00:47.027] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:47.027] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:89:0) after 1m0s
[20:01:47.121] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:89:0)
[20:01:47.121] Timer tick, asking Buildbucket for the build status
[20:01:47.271] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:47.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:90:0) after 1m0s
[20:02:47.443] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:90:0)
[20:02:47.443] Timer tick, asking Buildbucket for the build status
[20:02:47.535] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:47.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:91:0) after 1m0s
[20:03:47.713] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:91:0)
[20:03:47.713] Timer tick, asking Buildbucket for the build status
[20:03:47.976] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:47.976] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:92:0) after 1m0s
[20:04:48.102] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:92:0)
[20:04:48.102] Timer tick, asking Buildbucket for the build status
[20:04:48.498] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:48.498] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:93:0) after 1m0s
[20:05:48.619] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:93:0)
[20:05:48.619] Timer tick, asking Buildbucket for the build status
[20:05:48.699] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:48.699] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:94:0) after 1m0s
[20:06:48.799] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:94:0)
[20:06:48.799] Timer tick, asking Buildbucket for the build status
[20:06:48.872] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:48.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:95:0) after 1m0s
[20:07:49.010] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:95:0)
[20:07:49.010] Timer tick, asking Buildbucket for the build status
[20:07:49.331] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:49.331] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:96:0) after 1m0s
[20:08:49.380] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:96:0)
[20:08:49.380] Timer tick, asking Buildbucket for the build status
[20:08:49.441] Build 8866984062024986224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:49.441] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9032414124048064192:97:0) after 1m0s
[20:08:52.975] Received PubSub notification, asking Buildbucket for the build status
[20:08:53.099] Build 8866984062024986224: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:08:53.099] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1602187732750261",
"created_by": "project:fuchsia",
"created_ts": "1602182058271171",
"failure_reason": "BUILD_FAILURE",
"id": "8866984062024986224",
"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\": \"f9ff65d4dffbaf342dce7a8760059c27683cd962\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f9ff65d4dffbaf342dce7a8760059c27683cd962\", \"title\": \"f9ff65d4dffbaf342dce7a8760059c27683cd962\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/f9ff65d4dffbaf342dce7a8760059c27683cd962\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"51a948fdf0e14fb69ab9e0c79ae8b2415801f9a3\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@51a948fdf0e14fb69ab9e0c79ae8b2415801f9a3\", \"title\": \"51a948fdf0e14fb69ab9e0c79ae8b2415801f9a3\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/51a948fdf0e14fb69ab9e0c79ae8b2415801f9a3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"f511427204f281bc6278bb1facf6493518300806\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f511427204f281bc6278bb1facf6493518300806\", \"title\": \"f511427204f281bc6278bb1facf6493518300806\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/f511427204f281bc6278bb1facf6493518300806\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"f511427204f281bc6278bb1facf6493518300806\"}}",
"project": "fuchsia",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"revisions not unified: d4ec0a15afb7538247206aa9936071544fd860f8,f511427204f281bc6278bb1facf6493518300806:e4c9aac98611f63847ef6c57916808d9a2d7abcb,f511427204f281bc6278bb1facf6493518300806\"}, \"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-c-1-tg9v\"], \"image\": [\"fuchsia-debian-9-drawfork-v20200619-813ca9d23e\"], \"inside_docker\": [\"0\"], \"kvm\": [\"0\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-2\"], \"os\": [\"Debian\", \"Debian-9\", \"Debian-9.11\", \"Linux\"], \"pool\": [\"luci.fuchsia.prod\"], \"python\": [\"2.7.13\"], \"scale_group\": [\"fuchsia-prod-e2-2-ssd0\"], \"server_version\": [\"5570-fa4adf0\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}, \"ui\": {\"info\": \"revisions not unified: d4ec0a15afb7538247206aa9936071544fd860f8,f511427204f281bc6278bb1facf6493518300806:e4c9aac98611f63847ef6c57916808d9a2d7abcb,f511427204f281bc6278bb1facf6493518300806\"}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1602182065120157",
"status": "COMPLETED",
"status_changed_ts": "1602182065564042",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/f511427204f281bc6278bb1facf6493518300806",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/f511427204f281bc6278bb1facf6493518300806",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032414124048064192",
"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/8866984062024986224/+/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:4f224f9cbb8b7010",
"user_agent:luci-scheduler"
],
"updated_ts": "1602187732788303",
"url": "https://ci.chromium.org/b/8866984062024986224",
"utcnow_ts": "1602187733091237"
}
}
[20:08:53.099] Invocation finished in 1h34m36.141718526s with status FAILED