[06:34:10.593] New invocation is queued and will start shortly
[06:34:11.712] Starting the invocation (attempt 1)
[06:34:11.798] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:34:11.799] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:34:11.799] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9021950181174735520",
"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\":\"44b30b7f0e6fccb3fc678c84a8c2ad7d19b4a679\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@44b30b7f0e6fccb3fc678c84a8c2ad7d19b4a679\",\"title\":\"44b30b7f0e6fccb3fc678c84a8c2ad7d19b4a679\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/44b30b7f0e6fccb3fc678c84a8c2ad7d19b4a679\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"5f05936d9b14d2a75eaea7cc396052de268f8503\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@5f05936d9b14d2a75eaea7cc396052de268f8503\",\"title\":\"5f05936d9b14d2a75eaea7cc396052de268f8503\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/5f05936d9b14d2a75eaea7cc396052de268f8503\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"5bc4f5ca1554779f4e83702a4d92babd370384cd\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@5bc4f5ca1554779f4e83702a4d92babd370384cd\",\"title\":\"5bc4f5ca1554779f4e83702a4d92babd370384cd\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/5bc4f5ca1554779f4e83702a4d92babd370384cd\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"ba2f0de21691c6752daf4b3a6941392ee06a77d6\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@ba2f0de21691c6752daf4b3a6941392ee06a77d6\",\"title\":\"ba2f0de21691c6752daf4b3a6941392ee06a77d6\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/ba2f0de21691c6752daf4b3a6941392ee06a77d6\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"bccec180ce9593ccdf652ce3a625f6e0542ccf78\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@bccec180ce9593ccdf652ce3a625f6e0542ccf78\",\"title\":\"bccec180ce9593ccdf652ce3a625f6e0542ccf78\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/bccec180ce9593ccdf652ce3a625f6e0542ccf78\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"64515412441a35e8e7ced67efe4e5c9c4c88370b\"},\"id\":\"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@64515412441a35e8e7ced67efe4e5c9c4c88370b\",\"title\":\"64515412441a35e8e7ced67efe4e5c9c4c88370b\",\"url\":\"https://gnu.googlesource.com/binutils-gdb/+/64515412441a35e8e7ced67efe4e5c9c4c88370b\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://gnu.googlesource.com/binutils-gdb\",\"revision\":\"64515412441a35e8e7ced67efe4e5c9c4c88370b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-prod-trigger",
"scheduler_invocation_id:9021950181174735520",
"scheduler_job_id:fuchsia/gcc-prod-trigger-3e002780",
"user_agent:luci-scheduler",
"buildset:commit/git/64515412441a35e8e7ced67efe4e5c9c4c88370b",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/64515412441a35e8e7ced67efe4e5c9c4c88370b",
"gitiles_ref:refs/heads/master"
]
}
[06:34:12.359] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:fuchsia",
"created_ts": "1612161251879784",
"id": "8856520119107595328",
"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\": \"44b30b7f0e6fccb3fc678c84a8c2ad7d19b4a679\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@44b30b7f0e6fccb3fc678c84a8c2ad7d19b4a679\", \"title\": \"44b30b7f0e6fccb3fc678c84a8c2ad7d19b4a679\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/44b30b7f0e6fccb3fc678c84a8c2ad7d19b4a679\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"5f05936d9b14d2a75eaea7cc396052de268f8503\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@5f05936d9b14d2a75eaea7cc396052de268f8503\", \"title\": \"5f05936d9b14d2a75eaea7cc396052de268f8503\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/5f05936d9b14d2a75eaea7cc396052de268f8503\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"5bc4f5ca1554779f4e83702a4d92babd370384cd\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@5bc4f5ca1554779f4e83702a4d92babd370384cd\", \"title\": \"5bc4f5ca1554779f4e83702a4d92babd370384cd\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/5bc4f5ca1554779f4e83702a4d92babd370384cd\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"ba2f0de21691c6752daf4b3a6941392ee06a77d6\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@ba2f0de21691c6752daf4b3a6941392ee06a77d6\", \"title\": \"ba2f0de21691c6752daf4b3a6941392ee06a77d6\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/ba2f0de21691c6752daf4b3a6941392ee06a77d6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"bccec180ce9593ccdf652ce3a625f6e0542ccf78\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@bccec180ce9593ccdf652ce3a625f6e0542ccf78\", \"title\": \"bccec180ce9593ccdf652ce3a625f6e0542ccf78\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/bccec180ce9593ccdf652ce3a625f6e0542ccf78\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"64515412441a35e8e7ced67efe4e5c9c4c88370b\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@64515412441a35e8e7ced67efe4e5c9c4c88370b\", \"title\": \"64515412441a35e8e7ced67efe4e5c9c4c88370b\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/64515412441a35e8e7ced67efe4e5c9c4c88370b\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"64515412441a35e8e7ced67efe4e5c9c4c88370b\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612161252204874",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/64515412441a35e8e7ced67efe4e5c9c4c88370b",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/64515412441a35e8e7ced67efe4e5c9c4c88370b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021950181174735520",
"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/8856520119107595328/+/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": "1612161252205938",
"url": "https://ci.chromium.org/b/8856520119107595328",
"utcnow_ts": "1612161252345230"
}
}
[06:34:12.359] Task URL: https://ci.chromium.org/b/8856520119107595328
[06:34:12.359] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:2:0) after 1m0s
[06:34:36.587] Received PubSub notification, asking Buildbucket for the build status
[06:34:36.807] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:12.416] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:2:0)
[06:35:12.416] Timer tick, asking Buildbucket for the build status
[06:35:12.506] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:12.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:4:0) after 1m0s
[06:36:12.549] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:4:0)
[06:36:12.549] Timer tick, asking Buildbucket for the build status
[06:36:12.671] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:12.671] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:5:0) after 1m0s
[06:37:12.812] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:5:0)
[06:37:12.812] Timer tick, asking Buildbucket for the build status
[06:37:13.013] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:13.013] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:6:0) after 1m0s
[06:38:13.126] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:6:0)
[06:38:13.126] Timer tick, asking Buildbucket for the build status
[06:38:13.383] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:13.383] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:7:0) after 1m0s
[06:39:13.407] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:7:0)
[06:39:13.407] Timer tick, asking Buildbucket for the build status
[06:39:13.487] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:13.487] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:8:0) after 1m0s
[06:40:13.674] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:8:0)
[06:40:13.674] Timer tick, asking Buildbucket for the build status
[06:40:13.875] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:13.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:9:0) after 1m0s
[06:41:14.046] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:9:0)
[06:41:14.046] Timer tick, asking Buildbucket for the build status
[06:41:14.131] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:14.131] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:10:0) after 1m0s
[06:42:14.239] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:10:0)
[06:42:14.239] Timer tick, asking Buildbucket for the build status
[06:42:14.319] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:14.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:11:0) after 1m0s
[06:43:14.622] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:11:0)
[06:43:14.622] Timer tick, asking Buildbucket for the build status
[06:43:14.697] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:14.697] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:12:0) after 1m0s
[06:44:14.780] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:12:0)
[06:44:14.780] Timer tick, asking Buildbucket for the build status
[06:44:14.856] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:14.856] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:13:0) after 1m0s
[06:45:14.931] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:13:0)
[06:45:14.931] Timer tick, asking Buildbucket for the build status
[06:45:15.304] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:15.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:14:0) after 1m0s
[06:46:15.445] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:14:0)
[06:46:15.445] Timer tick, asking Buildbucket for the build status
[06:46:15.640] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:15.640] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:15:0) after 1m0s
[06:47:15.753] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:15:0)
[06:47:15.753] Timer tick, asking Buildbucket for the build status
[06:47:15.829] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:15.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:16:0) after 1m0s
[06:48:15.876] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:16:0)
[06:48:15.876] Timer tick, asking Buildbucket for the build status
[06:48:15.953] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:15.953] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:17:0) after 1m0s
[06:49:15.988] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:17:0)
[06:49:15.988] Timer tick, asking Buildbucket for the build status
[06:49:16.071] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:16.071] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:18:0) after 1m0s
[06:50:16.266] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:18:0)
[06:50:16.266] Timer tick, asking Buildbucket for the build status
[06:50:16.658] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:16.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:19:0) after 1m0s
[06:51:16.725] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:19:0)
[06:51:16.725] Timer tick, asking Buildbucket for the build status
[06:51:16.795] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:16.795] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:20:0) after 1m0s
[06:52:16.971] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:20:0)
[06:52:16.971] Timer tick, asking Buildbucket for the build status
[06:52:17.290] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:17.290] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:21:0) after 1m0s
[06:53:17.391] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:21:0)
[06:53:17.391] Timer tick, asking Buildbucket for the build status
[06:53:17.602] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:17.602] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:22:0) after 1m0s
[06:54:17.630] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:22:0)
[06:54:17.630] Timer tick, asking Buildbucket for the build status
[06:54:18.031] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:18.031] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:23:0) after 1m0s
[06:55:18.057] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:23:0)
[06:55:18.057] Timer tick, asking Buildbucket for the build status
[06:55:18.170] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:18.170] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:24:0) after 1m0s
[06:56:18.261] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:24:0)
[06:56:18.261] Timer tick, asking Buildbucket for the build status
[06:56:18.338] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:18.338] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:25:0) after 1m0s
[06:57:18.485] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:25:0)
[06:57:18.485] Timer tick, asking Buildbucket for the build status
[06:57:18.699] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:18.699] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:26:0) after 1m0s
[06:58:18.825] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:26:0)
[06:58:18.825] Timer tick, asking Buildbucket for the build status
[06:58:18.890] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:18.890] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:27:0) after 1m0s
[06:59:18.958] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:27:0)
[06:59:18.958] Timer tick, asking Buildbucket for the build status
[06:59:19.039] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:19.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:28:0) after 1m0s
[07:00:19.060] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:28:0)
[07:00:19.060] Timer tick, asking Buildbucket for the build status
[07:00:19.166] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:19.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:29:0) after 1m0s
[07:01:19.185] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:29:0)
[07:01:19.185] Timer tick, asking Buildbucket for the build status
[07:01:19.260] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:19.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:30:0) after 1m0s
[07:02:19.292] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:30:0)
[07:02:19.292] Timer tick, asking Buildbucket for the build status
[07:02:19.362] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:19.362] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:31:0) after 1m0s
[07:03:19.344] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:31:0)
[07:03:19.344] Timer tick, asking Buildbucket for the build status
[07:03:19.509] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:19.509] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:32:0) after 1m0s
[07:04:19.565] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:32:0)
[07:04:19.565] Timer tick, asking Buildbucket for the build status
[07:04:19.624] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:19.624] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:33:0) after 1m0s
[07:05:21.730] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:33:0)
[07:05:21.730] Timer tick, asking Buildbucket for the build status
[07:05:21.934] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:21.934] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:34:0) after 1m0s
[07:06:22.102] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:34:0)
[07:06:22.102] Timer tick, asking Buildbucket for the build status
[07:06:22.223] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:22.223] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:35:0) after 1m0s
[07:07:22.342] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:35:0)
[07:07:22.342] Timer tick, asking Buildbucket for the build status
[07:07:22.522] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:22.522] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:36:0) after 1m0s
[07:08:22.740] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:36:0)
[07:08:22.740] Timer tick, asking Buildbucket for the build status
[07:08:22.844] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:22.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:37:0) after 1m0s
[07:09:22.883] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:37:0)
[07:09:22.883] Timer tick, asking Buildbucket for the build status
[07:09:22.948] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:22.948] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:38:0) after 1m0s
[07:10:22.984] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:38:0)
[07:10:22.984] Timer tick, asking Buildbucket for the build status
[07:10:23.568] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:23.568] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:39:0) after 1m0s
[07:11:23.643] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:39:0)
[07:11:23.643] Timer tick, asking Buildbucket for the build status
[07:11:23.903] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:23.903] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:40:0) after 1m0s
[07:12:23.939] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:40:0)
[07:12:23.939] Timer tick, asking Buildbucket for the build status
[07:12:24.229] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:24.229] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:41:0) after 1m0s
[07:13:24.346] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:41:0)
[07:13:24.346] Timer tick, asking Buildbucket for the build status
[07:13:24.625] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:24.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:42:0) after 1m0s
[07:14:24.709] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:42:0)
[07:14:24.709] Timer tick, asking Buildbucket for the build status
[07:14:24.774] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:24.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:43:0) after 1m0s
[07:15:24.809] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:43:0)
[07:15:24.809] Timer tick, asking Buildbucket for the build status
[07:15:24.907] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:24.907] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:44:0) after 1m0s
[07:16:25.050] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:44:0)
[07:16:25.050] Timer tick, asking Buildbucket for the build status
[07:16:25.255] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:25.255] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:45:0) after 1m0s
[07:17:25.390] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:45:0)
[07:17:25.390] Timer tick, asking Buildbucket for the build status
[07:17:25.515] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:25.515] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:46:0) after 1m0s
[07:18:25.554] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:46:0)
[07:18:25.554] Timer tick, asking Buildbucket for the build status
[07:18:25.632] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:25.632] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:47:0) after 1m0s
[07:19:25.711] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:47:0)
[07:19:25.711] Timer tick, asking Buildbucket for the build status
[07:19:25.834] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:25.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:48:0) after 1m0s
[07:20:25.864] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:48:0)
[07:20:25.864] Timer tick, asking Buildbucket for the build status
[07:20:26.292] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:26.292] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:49:0) after 1m0s
[07:21:26.387] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:49:0)
[07:21:26.387] Timer tick, asking Buildbucket for the build status
[07:21:26.662] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:26.662] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:50:0) after 1m0s
[07:22:26.686] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:50:0)
[07:22:26.686] Timer tick, asking Buildbucket for the build status
[07:22:26.750] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:26.750] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:51:0) after 1m0s
[07:23:26.850] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:51:0)
[07:23:26.850] Timer tick, asking Buildbucket for the build status
[07:23:27.033] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:27.033] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:52:0) after 1m0s
[07:24:27.136] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:52:0)
[07:24:27.136] Timer tick, asking Buildbucket for the build status
[07:24:27.396] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:27.396] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:53:0) after 1m0s
[07:25:27.489] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:53:0)
[07:25:27.489] Timer tick, asking Buildbucket for the build status
[07:25:27.602] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:27.602] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:54:0) after 1m0s
[07:26:27.626] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:54:0)
[07:26:27.626] Timer tick, asking Buildbucket for the build status
[07:26:27.692] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:27.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:55:0) after 1m0s
[07:27:27.721] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:55:0)
[07:27:27.721] Timer tick, asking Buildbucket for the build status
[07:27:27.831] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:27.831] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:56:0) after 1m0s
[07:28:27.893] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:56:0)
[07:28:27.893] Timer tick, asking Buildbucket for the build status
[07:28:27.994] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:27.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:57:0) after 1m0s
[07:29:28.094] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:57:0)
[07:29:28.094] Timer tick, asking Buildbucket for the build status
[07:29:28.185] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:28.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:58:0) after 1m0s
[07:30:28.264] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:58:0)
[07:30:28.264] Timer tick, asking Buildbucket for the build status
[07:30:28.412] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:28.412] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:59:0) after 1m0s
[07:31:28.438] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:59:0)
[07:31:28.438] Timer tick, asking Buildbucket for the build status
[07:31:28.514] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:28.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:60:0) after 1m0s
[07:32:28.556] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:60:0)
[07:32:28.556] Timer tick, asking Buildbucket for the build status
[07:32:28.640] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:28.640] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:61:0) after 1m0s
[07:33:28.648] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:61:0)
[07:33:28.648] Timer tick, asking Buildbucket for the build status
[07:33:28.731] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:28.731] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:62:0) after 1m0s
[07:34:28.764] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:62:0)
[07:34:28.764] Timer tick, asking Buildbucket for the build status
[07:34:28.888] Build 8856520119107595328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:28.888] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9021950181174735520:63:0) after 1m0s
[07:35:19.755] Received PubSub notification, asking Buildbucket for the build status
[07:35:20.021] Build 8856520119107595328: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:35:20.021] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1612164918220283",
"created_by": "project:fuchsia",
"created_ts": "1612161251879784",
"id": "8856520119107595328",
"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\": \"44b30b7f0e6fccb3fc678c84a8c2ad7d19b4a679\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@44b30b7f0e6fccb3fc678c84a8c2ad7d19b4a679\", \"title\": \"44b30b7f0e6fccb3fc678c84a8c2ad7d19b4a679\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/44b30b7f0e6fccb3fc678c84a8c2ad7d19b4a679\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"5f05936d9b14d2a75eaea7cc396052de268f8503\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@5f05936d9b14d2a75eaea7cc396052de268f8503\", \"title\": \"5f05936d9b14d2a75eaea7cc396052de268f8503\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/5f05936d9b14d2a75eaea7cc396052de268f8503\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"5bc4f5ca1554779f4e83702a4d92babd370384cd\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@5bc4f5ca1554779f4e83702a4d92babd370384cd\", \"title\": \"5bc4f5ca1554779f4e83702a4d92babd370384cd\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/5bc4f5ca1554779f4e83702a4d92babd370384cd\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"ba2f0de21691c6752daf4b3a6941392ee06a77d6\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@ba2f0de21691c6752daf4b3a6941392ee06a77d6\", \"title\": \"ba2f0de21691c6752daf4b3a6941392ee06a77d6\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/ba2f0de21691c6752daf4b3a6941392ee06a77d6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"bccec180ce9593ccdf652ce3a625f6e0542ccf78\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@bccec180ce9593ccdf652ce3a625f6e0542ccf78\", \"title\": \"bccec180ce9593ccdf652ce3a625f6e0542ccf78\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/bccec180ce9593ccdf652ce3a625f6e0542ccf78\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"64515412441a35e8e7ced67efe4e5c9c4c88370b\"}, \"id\": \"https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@64515412441a35e8e7ced67efe4e5c9c4c88370b\", \"title\": \"64515412441a35e8e7ced67efe4e5c9c4c88370b\", \"url\": \"https://gnu.googlesource.com/binutils-gdb/+/64515412441a35e8e7ced67efe4e5c9c4c88370b\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://gnu.googlesource.com/binutils-gdb\", \"revision\": \"64515412441a35e8e7ced67efe4e5c9c4c88370b\"}}",
"project": "fuchsia",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"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-b-0-50b1\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1612161275859136",
"status": "COMPLETED",
"status_changed_ts": "1612164918803693",
"tags": [
"builder:gcc-prod-trigger",
"buildset:commit/git/64515412441a35e8e7ced67efe4e5c9c4c88370b",
"buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/64515412441a35e8e7ced67efe4e5c9c4c88370b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021950181174735520",
"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/8856520119107595328/+/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:51751e3a776cb010",
"user_agent:luci-scheduler"
],
"updated_ts": "1612164919126607",
"url": "https://ci.chromium.org/b/8856520119107595328",
"utcnow_ts": "1612164919999047"
}
}
[07:35:20.021] Invocation finished in 1h1m9.497425146s with status SUCCEEDED