[06:44:18.786] New invocation is queued and will start shortly
[06:44:19.877] Starting the invocation (attempt 1)
[06:44:19.915] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:44:19.915] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:44:19.915] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9079478617049569792",
"parameters_json": "{\"builder_name\":\"clang\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://fuchsia.googlesource.com/third_party/llvm-project\",\"revision\":\"aae9da70ffff41cc7eaf90726818f544cf498798\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:clang",
"scheduler_invocation_id:9079478617049569792",
"scheduler_job_id:fuchsia/prod-clang",
"user_agent:luci-scheduler",
"buildset:commit/git/aae9da70ffff41cc7eaf90726818f544cf498798",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/aae9da70ffff41cc7eaf90726818f544cf498798",
"gitiles_ref:refs/heads/master"
]
}
[06:44:20.980] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "AUTO",
"created_by": "project:fuchsia",
"created_ts": "1557297860005716",
"id": "8914048555105769376",
"parameters_json": "{\"builder_name\": \"clang\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"revision\": \"aae9da70ffff41cc7eaf90726818f544cf498798\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1557297860617232",
"tags": [
"builder:clang",
"buildset:commit/git/aae9da70ffff41cc7eaf90726818f544cf498798",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/aae9da70ffff41cc7eaf90726818f544cf498798",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9079478617049569792",
"scheduler_job_id:fuchsia/prod-clang",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/fuchsia/buildbucket/cr-buildbucket.appspot.com/8914048555105769376/+/annotations",
"swarming_tag:luci_project:fuchsia",
"swarming_tag:recipe_name:buildbucket_trigger",
"swarming_tag:recipe_package:fuchsia/infra/recipe_bundles/fuchsia.googlesource.com/infra/recipes",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1557297860617571",
"url": "https://ci.chromium.org/b/8914048555105769376",
"utcnow_ts": "1557297860955580"
}
}
[06:44:20.980] Task URL: https://ci.chromium.org/b/8914048555105769376
[06:44:20.980] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:2:0) after 1m0s
[06:44:23.174] Received PubSub notification, asking Buildbucket for the build status
[06:44:23.241] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:21.004] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:2:0)
[06:45:21.004] Timer tick, asking Buildbucket for the build status
[06:45:21.680] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:21.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:4:0) after 1m0s
[06:46:21.700] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:4:0)
[06:46:21.700] Timer tick, asking Buildbucket for the build status
[06:46:21.766] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:21.766] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:5:0) after 1m0s
[06:47:21.789] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:5:0)
[06:47:21.789] Timer tick, asking Buildbucket for the build status
[06:47:22.465] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:22.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:6:0) after 1m0s
[06:48:22.471] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:6:0)
[06:48:22.471] Timer tick, asking Buildbucket for the build status
[06:48:22.557] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:22.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:7:0) after 1m0s
[06:49:22.532] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:7:0)
[06:49:22.532] Timer tick, asking Buildbucket for the build status
[06:49:22.973] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:22.973] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:8:0) after 1m0s
[06:50:22.988] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:8:0)
[06:50:22.988] Timer tick, asking Buildbucket for the build status
[06:50:23.039] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:23.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:9:0) after 1m0s
[06:51:23.059] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:9:0)
[06:51:23.059] Timer tick, asking Buildbucket for the build status
[06:51:23.681] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:23.681] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:10:0) after 1m0s
[06:52:23.697] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:10:0)
[06:52:23.697] Timer tick, asking Buildbucket for the build status
[06:52:23.914] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:23.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:11:0) after 1m0s
[06:53:23.934] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:11:0)
[06:53:23.934] Timer tick, asking Buildbucket for the build status
[06:53:24.130] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:24.130] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:12:0) after 1m0s
[06:54:24.145] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:12:0)
[06:54:24.145] Timer tick, asking Buildbucket for the build status
[06:54:24.239] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:24.239] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:13:0) after 1m0s
[06:55:24.218] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:13:0)
[06:55:24.218] Timer tick, asking Buildbucket for the build status
[06:55:24.307] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:24.307] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:14:0) after 1m0s
[06:56:24.324] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:14:0)
[06:56:24.324] Timer tick, asking Buildbucket for the build status
[06:56:24.369] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:24.370] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:15:0) after 1m0s
[06:57:24.388] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:15:0)
[06:57:24.388] Timer tick, asking Buildbucket for the build status
[06:57:24.679] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:24.679] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:16:0) after 1m0s
[06:58:24.698] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:16:0)
[06:58:24.698] Timer tick, asking Buildbucket for the build status
[06:58:24.893] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:24.893] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:17:0) after 1m0s
[06:59:24.910] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:17:0)
[06:59:24.910] Timer tick, asking Buildbucket for the build status
[06:59:25.176] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:25.176] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:18:0) after 1m0s
[07:00:25.183] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:18:0)
[07:00:25.183] Timer tick, asking Buildbucket for the build status
[07:00:25.261] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:25.261] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:19:0) after 1m0s
[07:01:25.279] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:19:0)
[07:01:25.279] Timer tick, asking Buildbucket for the build status
[07:01:25.705] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:25.705] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:20:0) after 1m0s
[07:02:25.723] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:20:0)
[07:02:25.723] Timer tick, asking Buildbucket for the build status
[07:02:26.631] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:26.631] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:21:0) after 1m0s
[07:03:26.636] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:21:0)
[07:03:26.636] Timer tick, asking Buildbucket for the build status
[07:03:26.697] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:26.697] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:22:0) after 1m0s
[07:04:26.703] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:22:0)
[07:04:26.703] Timer tick, asking Buildbucket for the build status
[07:04:26.805] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:26.805] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:23:0) after 1m0s
[07:05:26.829] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:23:0)
[07:05:26.829] Timer tick, asking Buildbucket for the build status
[07:05:26.896] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:26.896] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:24:0) after 1m0s
[07:06:26.919] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:24:0)
[07:06:26.919] Timer tick, asking Buildbucket for the build status
[07:06:27.158] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:27.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:25:0) after 1m0s
[07:07:27.178] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:25:0)
[07:07:27.179] Timer tick, asking Buildbucket for the build status
[07:07:27.259] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:27.259] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:26:0) after 1m0s
[07:08:27.276] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:26:0)
[07:08:27.277] Timer tick, asking Buildbucket for the build status
[07:08:27.319] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:27.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:27:0) after 1m0s
[07:09:27.331] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:27:0)
[07:09:27.331] Timer tick, asking Buildbucket for the build status
[07:09:27.440] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:27.440] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:28:0) after 1m0s
[07:10:27.479] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:28:0)
[07:10:27.479] Timer tick, asking Buildbucket for the build status
[07:10:27.532] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:27.532] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:29:0) after 1m0s
[07:11:27.557] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:29:0)
[07:11:27.557] Timer tick, asking Buildbucket for the build status
[07:11:27.889] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:27.889] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:30:0) after 1m0s
[07:12:27.909] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:30:0)
[07:12:27.909] Timer tick, asking Buildbucket for the build status
[07:12:28.122] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:28.122] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:31:0) after 1m0s
[07:13:28.144] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:31:0)
[07:13:28.144] Timer tick, asking Buildbucket for the build status
[07:13:28.195] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:28.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:32:0) after 1m0s
[07:14:28.210] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:32:0)
[07:14:28.210] Timer tick, asking Buildbucket for the build status
[07:14:28.264] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:28.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:33:0) after 1m0s
[07:15:28.245] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:33:0)
[07:15:28.245] Timer tick, asking Buildbucket for the build status
[07:15:28.325] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:28.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:34:0) after 1m0s
[07:16:28.349] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:34:0)
[07:16:28.349] Timer tick, asking Buildbucket for the build status
[07:16:28.659] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:28.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:35:0) after 1m0s
[07:17:28.677] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:35:0)
[07:17:28.677] Timer tick, asking Buildbucket for the build status
[07:17:28.734] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:28.734] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:36:0) after 1m0s
[07:18:28.754] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:36:0)
[07:18:28.754] Timer tick, asking Buildbucket for the build status
[07:18:28.973] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:28.973] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:37:0) after 1m0s
[07:19:28.991] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:37:0)
[07:19:28.991] Timer tick, asking Buildbucket for the build status
[07:19:29.054] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:29.054] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:38:0) after 1m0s
[07:20:29.073] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:38:0)
[07:20:29.073] Timer tick, asking Buildbucket for the build status
[07:20:29.113] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:29.113] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:39:0) after 1m0s
[07:21:29.156] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:39:0)
[07:21:29.156] Timer tick, asking Buildbucket for the build status
[07:21:29.323] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:29.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:40:0) after 1m0s
[07:22:29.338] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:40:0)
[07:22:29.338] Timer tick, asking Buildbucket for the build status
[07:22:29.577] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:29.577] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:41:0) after 1m0s
[07:23:29.564] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:41:0)
[07:23:29.564] Timer tick, asking Buildbucket for the build status
[07:23:29.702] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:29.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:42:0) after 1m0s
[07:24:29.719] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:42:0)
[07:24:29.719] Timer tick, asking Buildbucket for the build status
[07:24:29.805] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:29.805] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:43:0) after 1m0s
[07:25:29.818] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:43:0)
[07:25:29.818] Timer tick, asking Buildbucket for the build status
[07:25:29.909] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:29.909] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:44:0) after 1m0s
[07:26:29.927] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:44:0)
[07:26:29.927] Timer tick, asking Buildbucket for the build status
[07:26:29.980] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:29.980] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:45:0) after 1m0s
[07:27:29.999] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:45:0)
[07:27:29.999] Timer tick, asking Buildbucket for the build status
[07:27:30.129] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:30.129] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:46:0) after 1m0s
[07:28:30.119] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:46:0)
[07:28:30.119] Timer tick, asking Buildbucket for the build status
[07:28:30.446] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:30.446] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:47:0) after 1m0s
[07:29:30.467] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:47:0)
[07:29:30.467] Timer tick, asking Buildbucket for the build status
[07:29:30.549] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:30.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:48:0) after 1m0s
[07:30:30.569] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:48:0)
[07:30:30.569] Timer tick, asking Buildbucket for the build status
[07:30:30.627] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:30.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:49:0) after 1m0s
[07:31:30.637] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:49:0)
[07:31:30.637] Timer tick, asking Buildbucket for the build status
[07:31:30.781] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:30.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:50:0) after 1m0s
[07:32:30.814] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:50:0)
[07:32:30.814] Timer tick, asking Buildbucket for the build status
[07:32:30.874] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:30.874] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:51:0) after 1m0s
[07:33:30.897] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:51:0)
[07:33:30.897] Timer tick, asking Buildbucket for the build status
[07:33:31.006] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:31.006] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:52:0) after 1m0s
[07:34:31.034] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:52:0)
[07:34:31.034] Timer tick, asking Buildbucket for the build status
[07:34:31.192] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:31.192] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:53:0) after 1m0s
[07:35:31.211] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:53:0)
[07:35:31.211] Timer tick, asking Buildbucket for the build status
[07:35:31.306] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:31.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:54:0) after 1m0s
[07:36:31.347] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:54:0)
[07:36:31.347] Timer tick, asking Buildbucket for the build status
[07:36:31.397] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:31.397] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:55:0) after 1m0s
[07:37:31.413] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:55:0)
[07:37:31.413] Timer tick, asking Buildbucket for the build status
[07:37:31.623] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:31.623] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:56:0) after 1m0s
[07:38:31.684] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:56:0)
[07:38:31.684] Timer tick, asking Buildbucket for the build status
[07:38:31.935] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:31.935] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:57:0) after 1m0s
[07:39:31.918] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:57:0)
[07:39:31.918] Timer tick, asking Buildbucket for the build status
[07:39:32.008] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:32.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:58:0) after 1m0s
[07:40:32.045] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:58:0)
[07:40:32.045] Timer tick, asking Buildbucket for the build status
[07:40:32.094] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:32.094] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:59:0) after 1m0s
[07:41:32.097] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:59:0)
[07:41:32.097] Timer tick, asking Buildbucket for the build status
[07:41:32.375] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:32.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:60:0) after 1m0s
[07:42:32.378] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:60:0)
[07:42:32.378] Timer tick, asking Buildbucket for the build status
[07:42:32.656] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:32.656] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:61:0) after 1m0s
[07:43:32.677] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:61:0)
[07:43:32.677] Timer tick, asking Buildbucket for the build status
[07:43:32.716] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:32.716] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:62:0) after 1m0s
[07:44:32.708] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:62:0)
[07:44:32.708] Timer tick, asking Buildbucket for the build status
[07:44:32.947] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:32.947] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:63:0) after 1m0s
[07:45:32.930] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:63:0)
[07:45:32.930] Timer tick, asking Buildbucket for the build status
[07:45:33.132] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:33.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:64:0) after 1m0s
[07:46:33.166] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:64:0)
[07:46:33.166] Timer tick, asking Buildbucket for the build status
[07:46:33.221] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:33.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:65:0) after 1m0s
[07:47:33.240] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:65:0)
[07:47:33.240] Timer tick, asking Buildbucket for the build status
[07:47:33.459] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:33.459] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:66:0) after 1m0s
[07:48:33.471] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:66:0)
[07:48:33.471] Timer tick, asking Buildbucket for the build status
[07:48:33.517] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:33.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:67:0) after 1m0s
[07:49:33.507] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:67:0)
[07:49:33.507] Timer tick, asking Buildbucket for the build status
[07:49:33.583] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:33.583] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:68:0) after 1m0s
[07:50:33.564] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:68:0)
[07:50:33.564] Timer tick, asking Buildbucket for the build status
[07:50:33.602] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:33.602] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:69:0) after 1m0s
[07:51:33.624] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:69:0)
[07:51:33.624] Timer tick, asking Buildbucket for the build status
[07:51:33.712] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:33.712] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:70:0) after 1m0s
[07:52:33.740] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:70:0)
[07:52:33.740] Timer tick, asking Buildbucket for the build status
[07:52:33.854] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:33.854] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:71:0) after 1m0s
[07:53:33.866] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:71:0)
[07:53:33.866] Timer tick, asking Buildbucket for the build status
[07:53:33.958] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:33.958] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:72:0) after 1m0s
[07:54:33.950] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:72:0)
[07:54:33.950] Timer tick, asking Buildbucket for the build status
[07:54:34.009] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:34.009] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:73:0) after 1m0s
[07:55:33.994] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:73:0)
[07:55:33.994] Timer tick, asking Buildbucket for the build status
[07:55:34.041] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:34.041] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:74:0) after 1m0s
[07:56:34.065] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:74:0)
[07:56:34.065] Timer tick, asking Buildbucket for the build status
[07:56:34.186] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:34.186] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:75:0) after 1m0s
[07:57:34.221] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:75:0)
[07:57:34.221] Timer tick, asking Buildbucket for the build status
[07:57:34.479] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:34.479] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:76:0) after 1m0s
[07:58:34.502] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:76:0)
[07:58:34.502] Timer tick, asking Buildbucket for the build status
[07:58:34.558] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:34.558] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:77:0) after 1m0s
[07:59:34.542] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:77:0)
[07:59:34.542] Timer tick, asking Buildbucket for the build status
[07:59:34.662] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:34.662] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:78:0) after 1m0s
[08:00:34.702] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:78:0)
[08:00:34.702] Timer tick, asking Buildbucket for the build status
[08:00:34.755] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:34.755] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:79:0) after 1m0s
[08:01:34.778] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:79:0)
[08:01:34.778] Timer tick, asking Buildbucket for the build status
[08:01:34.935] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:34.935] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:80:0) after 1m0s
[08:02:34.964] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:80:0)
[08:02:34.964] Timer tick, asking Buildbucket for the build status
[08:02:35.100] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:35.100] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:81:0) after 1m0s
[08:03:35.121] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:81:0)
[08:03:35.121] Timer tick, asking Buildbucket for the build status
[08:03:35.241] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:35.241] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:82:0) after 1m0s
[08:04:35.238] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:82:0)
[08:04:35.238] Timer tick, asking Buildbucket for the build status
[08:04:35.739] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:35.739] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:83:0) after 1m0s
[08:05:35.762] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:83:0)
[08:05:35.762] Timer tick, asking Buildbucket for the build status
[08:05:35.844] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:35.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:84:0) after 1m0s
[08:06:35.849] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:84:0)
[08:06:35.849] Timer tick, asking Buildbucket for the build status
[08:06:36.191] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:36.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:85:0) after 1m0s
[08:07:36.215] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:85:0)
[08:07:36.215] Timer tick, asking Buildbucket for the build status
[08:07:36.289] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:36.289] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:86:0) after 1m0s
[08:08:36.321] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:86:0)
[08:08:36.321] Timer tick, asking Buildbucket for the build status
[08:08:36.373] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:36.373] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:87:0) after 1m0s
[08:09:36.408] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:87:0)
[08:09:36.408] Timer tick, asking Buildbucket for the build status
[08:09:36.514] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:36.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:88:0) after 1m0s
[08:10:36.492] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:88:0)
[08:10:36.492] Timer tick, asking Buildbucket for the build status
[08:10:36.712] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:36.712] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:89:0) after 1m0s
[08:11:36.725] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:89:0)
[08:11:36.725] Timer tick, asking Buildbucket for the build status
[08:11:36.836] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:36.836] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:90:0) after 1m0s
[08:12:36.858] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:90:0)
[08:12:36.858] Timer tick, asking Buildbucket for the build status
[08:12:37.239] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:37.239] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:91:0) after 1m0s
[08:13:37.234] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:91:0)
[08:13:37.234] Timer tick, asking Buildbucket for the build status
[08:13:37.286] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:37.286] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:92:0) after 1m0s
[08:14:37.294] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:92:0)
[08:14:37.294] Timer tick, asking Buildbucket for the build status
[08:14:37.638] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:37.638] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:93:0) after 1m0s
[08:15:37.616] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:93:0)
[08:15:37.616] Timer tick, asking Buildbucket for the build status
[08:15:38.385] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:38.385] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:94:0) after 1m0s
[08:16:38.420] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:94:0)
[08:16:38.420] Timer tick, asking Buildbucket for the build status
[08:16:38.591] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:38.591] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:95:0) after 1m0s
[08:17:38.574] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:95:0)
[08:17:38.574] Timer tick, asking Buildbucket for the build status
[08:17:38.812] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:38.812] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:96:0) after 1m0s
[08:18:38.833] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:96:0)
[08:18:38.833] Timer tick, asking Buildbucket for the build status
[08:18:39.270] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:39.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:97:0) after 1m0s
[08:19:39.279] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:97:0)
[08:19:39.279] Timer tick, asking Buildbucket for the build status
[08:19:39.454] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:39.454] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:98:0) after 1m0s
[08:20:39.524] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:98:0)
[08:20:39.524] Timer tick, asking Buildbucket for the build status
[08:20:39.654] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:39.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:99:0) after 1m0s
[08:21:39.676] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:99:0)
[08:21:39.676] Timer tick, asking Buildbucket for the build status
[08:21:40.237] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:40.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:100:0) after 1m0s
[08:22:40.261] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:100:0)
[08:22:40.261] Timer tick, asking Buildbucket for the build status
[08:22:40.723] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:40.723] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:101:0) after 1m0s
[08:23:40.750] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:101:0)
[08:23:40.750] Timer tick, asking Buildbucket for the build status
[08:23:41.196] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:41.196] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:102:0) after 1m0s
[08:24:41.217] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:102:0)
[08:24:41.217] Timer tick, asking Buildbucket for the build status
[08:24:41.292] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:41.292] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:103:0) after 1m0s
[08:25:41.316] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:103:0)
[08:25:41.316] Timer tick, asking Buildbucket for the build status
[08:25:41.358] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:41.358] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:104:0) after 1m0s
[08:26:41.336] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:104:0)
[08:26:41.336] Timer tick, asking Buildbucket for the build status
[08:26:41.403] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:41.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:105:0) after 1m0s
[08:27:41.424] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:105:0)
[08:27:41.424] Timer tick, asking Buildbucket for the build status
[08:27:41.521] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:41.521] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:106:0) after 1m0s
[08:28:41.543] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:106:0)
[08:28:41.543] Timer tick, asking Buildbucket for the build status
[08:28:41.664] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:41.664] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:107:0) after 1m0s
[08:29:41.639] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:107:0)
[08:29:41.639] Timer tick, asking Buildbucket for the build status
[08:29:41.693] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:41.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:108:0) after 1m0s
[08:30:41.688] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:108:0)
[08:30:41.688] Timer tick, asking Buildbucket for the build status
[08:30:41.744] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:41.744] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:109:0) after 1m0s
[08:31:41.726] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:109:0)
[08:31:41.726] Timer tick, asking Buildbucket for the build status
[08:31:41.993] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:41.993] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:110:0) after 1m0s
[08:32:42.018] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:110:0)
[08:32:42.018] Timer tick, asking Buildbucket for the build status
[08:32:43.214] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:43.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:111:0) after 1m0s
[08:33:43.225] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:111:0)
[08:33:43.225] Timer tick, asking Buildbucket for the build status
[08:33:43.335] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:43.335] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:112:0) after 1m0s
[08:34:43.355] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:112:0)
[08:34:43.355] Timer tick, asking Buildbucket for the build status
[08:34:43.406] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:43.406] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:113:0) after 1m0s
[08:35:43.431] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:113:0)
[08:35:43.431] Timer tick, asking Buildbucket for the build status
[08:35:43.521] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:43.521] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:114:0) after 1m0s
[08:36:43.560] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:114:0)
[08:36:43.560] Timer tick, asking Buildbucket for the build status
[08:36:44.076] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:44.076] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:115:0) after 1m0s
[08:37:44.111] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:115:0)
[08:37:44.111] Timer tick, asking Buildbucket for the build status
[08:37:44.315] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:44.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:116:0) after 1m0s
[08:38:44.341] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:116:0)
[08:38:44.341] Timer tick, asking Buildbucket for the build status
[08:38:44.412] Build 8914048555105769376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:44.412] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9079478617049569792:117:0) after 1m0s
[08:39:26.004] Received PubSub notification, asking Buildbucket for the build status
[08:39:26.288] Build 8914048555105769376: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:39:26.288] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "AUTO",
"completed_ts": "1557304764818793",
"created_by": "project:fuchsia",
"created_ts": "1557297860005716",
"id": "8914048555105769376",
"parameters_json": "{\"builder_name\": \"clang\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"revision\": \"aae9da70ffff41cc7eaf90726818f544cf498798\"}}",
"project": "fuchsia",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"fuchsia-debian-1-003729e9-us-central1-c-nv9f\", \"branch\": \"refs/heads/master\", \"buildername\": \"clang\", \"builders\": [\"clang-linux-arm64\", \"clang-linux-x64\", \"clang-mac-x64\"], \"path_config\": \"generic\", \"recipe\": \"buildbucket_trigger\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"revision\": \"aae9da70ffff41cc7eaf90726818f544cf498798\", \"timeout\": 7200.0}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"vpython\"], \"cores\": [\"1\"], \"cpu\": [\"x64\", \"x86\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"fuchsia-debian-1-003729e9-us-central1-c-nv9f\"], \"image\": [\"fuchsia-debian-9-drawfork-v20190426-c90e1d5-prod\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-1\"], \"os\": [\"Debian\", \"Debian-9.5\", \"Linux\"], \"pool\": [\"luci.fuchsia.prod\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4291-fed3552\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1557297862444744",
"status": "COMPLETED",
"status_changed_ts": "1557304765614291",
"tags": [
"builder:clang",
"buildset:commit/git/aae9da70ffff41cc7eaf90726818f544cf498798",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/aae9da70ffff41cc7eaf90726818f544cf498798",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9079478617049569792",
"scheduler_job_id:fuchsia/prod-clang",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/fuchsia/buildbucket/cr-buildbucket.appspot.com/8914048555105769376/+/annotations",
"swarming_tag:luci_project:fuchsia",
"swarming_tag:os:Debian",
"swarming_tag:recipe_name:buildbucket_trigger",
"swarming_tag:recipe_package:fuchsia/infra/recipe_bundles/fuchsia.googlesource.com/infra/recipes",
"swarming_task_id:44af011aa3b7c810",
"user_agent:luci-scheduler"
],
"updated_ts": "1557304765632865",
"url": "https://ci.chromium.org/b/8914048555105769376",
"utcnow_ts": "1557304766258266"
}
}
[08:39:26.288] Invocation finished in 1h55m7.52042908s with status SUCCEEDED