[07:04:48.540] New invocation is queued and will start shortly
[07:04:49.809] Starting the invocation (attempt 1)
[07:04:49.862] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:04:49.862] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:04:49.862] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9084550757677714064",
"parameters_json": "{\"builder_name\":\"clang\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://fuchsia.googlesource.com/third_party/llvm-project\",\"revision\":\"09ebdc03fefb4c9d61128311066cca632d8e1053\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:clang",
"scheduler_invocation_id:9084550757677714064",
"scheduler_job_id:fuchsia/prod-clang",
"user_agent:luci-scheduler",
"buildset:commit/git/09ebdc03fefb4c9d61128311066cca632d8e1053",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/09ebdc03fefb4c9d61128311066cca632d8e1053",
"gitiles_ref:refs/heads/master"
]
}
[07:04:51.042] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552460689949751",
"id": "8919120695534351360",
"lease_expiration_ts": "1552586690586991",
"lease_key": "1394509172",
"parameters_json": "{\"builder_name\": \"clang\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"revision\": \"09ebdc03fefb4c9d61128311066cca632d8e1053\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1552460690913250",
"tags": [
"builder:clang",
"buildset:commit/git/09ebdc03fefb4c9d61128311066cca632d8e1053",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/09ebdc03fefb4c9d61128311066cca632d8e1053",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9084550757677714064",
"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/8919120695534351360/+/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:438eafbba289b910",
"user_agent:luci-scheduler"
],
"updated_ts": "1552460690913466",
"url": "https://ci.chromium.org/b/8919120695534351360",
"utcnow_ts": "1552460691033206"
}
}
[07:04:51.042] Task URL: https://ci.chromium.org/b/8919120695534351360
[07:04:51.042] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:2:0) after 1m0s
[07:04:55.799] Received PubSub notification, asking Buildbucket for the build status
[07:04:55.839] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:51.073] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:2:0)
[07:05:51.073] Timer tick, asking Buildbucket for the build status
[07:05:51.225] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:51.225] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:4:0) after 1m0s
[07:06:51.223] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:4:0)
[07:06:51.223] Timer tick, asking Buildbucket for the build status
[07:06:51.283] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:51.283] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:5:0) after 1m0s
[07:07:51.304] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:5:0)
[07:07:51.304] Timer tick, asking Buildbucket for the build status
[07:07:51.486] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:51.486] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:6:0) after 1m0s
[07:08:51.502] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:6:0)
[07:08:51.502] Timer tick, asking Buildbucket for the build status
[07:08:51.869] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:51.869] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:7:0) after 1m0s
[07:09:51.892] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:7:0)
[07:09:51.892] Timer tick, asking Buildbucket for the build status
[07:09:51.992] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:51.992] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:8:0) after 1m0s
[07:10:51.971] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:8:0)
[07:10:51.971] Timer tick, asking Buildbucket for the build status
[07:10:52.103] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:52.103] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:9:0) after 1m0s
[07:11:52.124] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:9:0)
[07:11:52.124] Timer tick, asking Buildbucket for the build status
[07:11:52.319] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:52.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:10:0) after 1m0s
[07:12:52.328] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:10:0)
[07:12:52.328] Timer tick, asking Buildbucket for the build status
[07:12:52.789] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:52.789] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:11:0) after 1m0s
[07:13:52.779] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:11:0)
[07:13:52.779] Timer tick, asking Buildbucket for the build status
[07:13:52.835] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:52.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:12:0) after 1m0s
[07:14:52.848] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:12:0)
[07:14:52.848] Timer tick, asking Buildbucket for the build status
[07:14:52.917] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:52.917] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:13:0) after 1m0s
[07:15:52.931] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:13:0)
[07:15:52.931] Timer tick, asking Buildbucket for the build status
[07:15:52.995] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:52.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:14:0) after 1m0s
[07:16:53.022] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:14:0)
[07:16:53.022] Timer tick, asking Buildbucket for the build status
[07:16:53.084] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:53.084] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:15:0) after 1m0s
[07:17:53.085] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:15:0)
[07:17:53.085] Timer tick, asking Buildbucket for the build status
[07:17:53.435] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:53.435] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:16:0) after 1m0s
[07:18:53.460] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:16:0)
[07:18:53.460] Timer tick, asking Buildbucket for the build status
[07:18:53.580] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:53.580] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:17:0) after 1m0s
[07:19:53.583] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:17:0)
[07:19:53.583] Timer tick, asking Buildbucket for the build status
[07:19:53.680] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:53.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:18:0) after 1m0s
[07:20:53.698] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:18:0)
[07:20:53.698] Timer tick, asking Buildbucket for the build status
[07:20:53.745] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:53.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:19:0) after 1m0s
[07:21:53.762] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:19:0)
[07:21:53.762] Timer tick, asking Buildbucket for the build status
[07:21:53.811] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:53.811] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:20:0) after 1m0s
[07:22:53.830] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:20:0)
[07:22:53.831] Timer tick, asking Buildbucket for the build status
[07:22:53.888] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:53.888] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:21:0) after 1m0s
[07:23:53.882] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:21:0)
[07:23:53.882] Timer tick, asking Buildbucket for the build status
[07:23:54.078] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:54.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:22:0) after 1m0s
[07:24:54.057] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:22:0)
[07:24:54.057] Timer tick, asking Buildbucket for the build status
[07:24:54.245] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:54.245] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:23:0) after 1m0s
[07:25:54.226] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:23:0)
[07:25:54.226] Timer tick, asking Buildbucket for the build status
[07:25:54.368] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:54.368] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:24:0) after 1m0s
[07:26:54.381] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:24:0)
[07:26:54.381] Timer tick, asking Buildbucket for the build status
[07:26:54.429] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:54.429] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:25:0) after 1m0s
[07:27:54.454] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:25:0)
[07:27:54.454] Timer tick, asking Buildbucket for the build status
[07:27:54.688] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:54.688] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:26:0) after 1m0s
[07:28:54.706] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:26:0)
[07:28:54.706] Timer tick, asking Buildbucket for the build status
[07:28:54.804] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:54.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:27:0) after 1m0s
[07:29:54.821] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:27:0)
[07:29:54.821] Timer tick, asking Buildbucket for the build status
[07:29:54.958] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:54.958] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:28:0) after 1m0s
[07:30:54.962] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:28:0)
[07:30:54.962] Timer tick, asking Buildbucket for the build status
[07:30:55.058] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:55.058] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:29:0) after 1m0s
[07:31:55.079] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:29:0)
[07:31:55.079] Timer tick, asking Buildbucket for the build status
[07:31:55.138] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:55.138] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:30:0) after 1m0s
[07:32:55.160] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:30:0)
[07:32:55.160] Timer tick, asking Buildbucket for the build status
[07:32:55.271] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:55.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:31:0) after 1m0s
[07:33:55.285] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:31:0)
[07:33:55.285] Timer tick, asking Buildbucket for the build status
[07:33:55.596] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:55.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:32:0) after 1m0s
[07:34:55.614] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:32:0)
[07:34:55.614] Timer tick, asking Buildbucket for the build status
[07:34:55.698] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:55.698] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:33:0) after 1m0s
[07:35:55.675] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:33:0)
[07:35:55.675] Timer tick, asking Buildbucket for the build status
[07:35:55.848] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:55.848] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:34:0) after 1m0s
[07:36:55.829] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:34:0)
[07:36:55.829] Timer tick, asking Buildbucket for the build status
[07:36:55.886] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:55.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:35:0) after 1m0s
[07:37:55.877] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:35:0)
[07:37:55.877] Timer tick, asking Buildbucket for the build status
[07:37:55.937] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:55.937] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:36:0) after 1m0s
[07:38:55.958] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:36:0)
[07:38:55.958] Timer tick, asking Buildbucket for the build status
[07:38:56.014] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:56.014] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:37:0) after 1m0s
[07:39:56.015] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:37:0)
[07:39:56.015] Timer tick, asking Buildbucket for the build status
[07:39:56.073] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:56.073] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:38:0) after 1m0s
[07:40:56.043] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:38:0)
[07:40:56.043] Timer tick, asking Buildbucket for the build status
[07:40:56.145] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:56.145] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:39:0) after 1m0s
[07:41:56.175] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:39:0)
[07:41:56.175] Timer tick, asking Buildbucket for the build status
[07:41:56.249] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:56.249] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:40:0) after 1m0s
[07:42:56.265] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:40:0)
[07:42:56.266] Timer tick, asking Buildbucket for the build status
[07:42:56.337] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:56.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:41:0) after 1m0s
[07:43:56.365] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:41:0)
[07:43:56.365] Timer tick, asking Buildbucket for the build status
[07:43:56.450] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:56.450] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:42:0) after 1m0s
[07:44:56.469] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:42:0)
[07:44:56.469] Timer tick, asking Buildbucket for the build status
[07:44:56.529] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:56.529] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:43:0) after 1m0s
[07:45:56.548] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:43:0)
[07:45:56.548] Timer tick, asking Buildbucket for the build status
[07:45:56.609] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:56.609] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:44:0) after 1m0s
[07:46:56.640] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:44:0)
[07:46:56.640] Timer tick, asking Buildbucket for the build status
[07:46:56.700] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:56.700] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:45:0) after 1m0s
[07:47:56.705] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:45:0)
[07:47:56.705] Timer tick, asking Buildbucket for the build status
[07:47:56.750] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:56.750] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:46:0) after 1m0s
[07:48:56.729] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:46:0)
[07:48:56.729] Timer tick, asking Buildbucket for the build status
[07:48:56.785] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:56.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:47:0) after 1m0s
[07:49:56.792] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:47:0)
[07:49:56.792] Timer tick, asking Buildbucket for the build status
[07:49:56.967] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:56.967] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:48:0) after 1m0s
[07:50:56.993] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:48:0)
[07:50:56.993] Timer tick, asking Buildbucket for the build status
[07:50:57.196] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:57.196] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:49:0) after 1m0s
[07:51:57.215] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:49:0)
[07:51:57.215] Timer tick, asking Buildbucket for the build status
[07:51:57.274] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:57.274] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:50:0) after 1m0s
[07:52:57.294] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:50:0)
[07:52:57.294] Timer tick, asking Buildbucket for the build status
[07:52:57.334] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:57.334] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:51:0) after 1m0s
[07:53:57.355] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:51:0)
[07:53:57.355] Timer tick, asking Buildbucket for the build status
[07:53:57.411] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:57.411] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:52:0) after 1m0s
[07:54:57.438] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:52:0)
[07:54:57.438] Timer tick, asking Buildbucket for the build status
[07:54:57.582] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:57.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:53:0) after 1m0s
[07:55:57.575] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:53:0)
[07:55:57.575] Timer tick, asking Buildbucket for the build status
[07:55:57.616] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:57.616] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:54:0) after 1m0s
[07:56:57.599] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:54:0)
[07:56:57.599] Timer tick, asking Buildbucket for the build status
[07:56:57.729] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:57.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:55:0) after 1m0s
[07:57:57.756] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:55:0)
[07:57:57.756] Timer tick, asking Buildbucket for the build status
[07:57:57.873] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:57.873] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:56:0) after 1m0s
[07:58:57.879] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:56:0)
[07:58:57.879] Timer tick, asking Buildbucket for the build status
[07:58:57.947] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:57.947] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:57:0) after 1m0s
[07:59:57.970] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:57:0)
[07:59:57.970] Timer tick, asking Buildbucket for the build status
[07:59:58.100] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:58.100] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:58:0) after 1m0s
[08:00:58.119] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:58:0)
[08:00:58.119] Timer tick, asking Buildbucket for the build status
[08:00:58.161] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:58.162] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:59:0) after 1m0s
[08:01:58.188] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:59:0)
[08:01:58.188] Timer tick, asking Buildbucket for the build status
[08:01:58.317] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:58.317] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:60:0) after 1m0s
[08:02:58.337] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:60:0)
[08:02:58.337] Timer tick, asking Buildbucket for the build status
[08:02:58.648] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:58.648] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:61:0) after 1m0s
[08:03:58.671] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:61:0)
[08:03:58.671] Timer tick, asking Buildbucket for the build status
[08:03:58.735] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:58.735] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:62:0) after 1m0s
[08:04:58.756] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:62:0)
[08:04:58.757] Timer tick, asking Buildbucket for the build status
[08:04:58.799] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:58.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:63:0) after 1m0s
[08:05:58.787] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:63:0)
[08:05:58.787] Timer tick, asking Buildbucket for the build status
[08:05:58.850] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:58.850] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:64:0) after 1m0s
[08:06:58.846] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:64:0)
[08:06:58.846] Timer tick, asking Buildbucket for the build status
[08:06:58.907] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:58.907] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:65:0) after 1m0s
[08:07:58.911] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:65:0)
[08:07:58.911] Timer tick, asking Buildbucket for the build status
[08:07:58.967] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:58.967] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:66:0) after 1m0s
[08:08:58.975] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:66:0)
[08:08:58.975] Timer tick, asking Buildbucket for the build status
[08:08:59.074] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:59.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:67:0) after 1m0s
[08:09:59.055] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:67:0)
[08:09:59.055] Timer tick, asking Buildbucket for the build status
[08:09:59.098] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:59.098] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:68:0) after 1m0s
[08:10:59.069] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:68:0)
[08:10:59.069] Timer tick, asking Buildbucket for the build status
[08:10:59.119] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:59.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:69:0) after 1m0s
[08:11:59.141] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:69:0)
[08:11:59.141] Timer tick, asking Buildbucket for the build status
[08:11:59.201] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:59.201] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:70:0) after 1m0s
[08:12:59.183] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:70:0)
[08:12:59.183] Timer tick, asking Buildbucket for the build status
[08:12:59.243] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:59.243] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:71:0) after 1m0s
[08:13:59.265] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:71:0)
[08:13:59.265] Timer tick, asking Buildbucket for the build status
[08:13:59.586] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:59.586] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:72:0) after 1m0s
[08:14:59.616] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:72:0)
[08:14:59.616] Timer tick, asking Buildbucket for the build status
[08:14:59.686] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:59.686] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:73:0) after 1m0s
[08:15:59.729] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:73:0)
[08:15:59.729] Timer tick, asking Buildbucket for the build status
[08:15:59.778] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:59.778] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:74:0) after 1m0s
[08:16:59.833] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:74:0)
[08:16:59.833] Timer tick, asking Buildbucket for the build status
[08:16:59.973] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:59.973] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:75:0) after 1m0s
[08:17:59.989] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:75:0)
[08:17:59.989] Timer tick, asking Buildbucket for the build status
[08:18:00.098] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:00.098] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:76:0) after 1m0s
[08:19:00.121] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:76:0)
[08:19:00.121] Timer tick, asking Buildbucket for the build status
[08:19:00.302] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:00.302] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:77:0) after 1m0s
[08:20:00.286] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:77:0)
[08:20:00.286] Timer tick, asking Buildbucket for the build status
[08:20:00.358] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:00.358] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:78:0) after 1m0s
[08:21:00.387] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:78:0)
[08:21:00.387] Timer tick, asking Buildbucket for the build status
[08:21:00.434] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:00.434] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:79:0) after 1m0s
[08:22:00.459] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:79:0)
[08:22:00.459] Timer tick, asking Buildbucket for the build status
[08:22:00.518] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:00.518] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:80:0) after 1m0s
[08:23:00.488] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:80:0)
[08:23:00.488] Timer tick, asking Buildbucket for the build status
[08:23:00.527] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:00.528] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:81:0) after 1m0s
[08:24:00.549] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:81:0)
[08:24:00.549] Timer tick, asking Buildbucket for the build status
[08:24:00.709] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:00.709] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:82:0) after 1m0s
[08:25:00.728] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:82:0)
[08:25:00.728] Timer tick, asking Buildbucket for the build status
[08:25:00.873] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:00.873] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:83:0) after 1m0s
[08:26:00.900] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:83:0)
[08:26:00.900] Timer tick, asking Buildbucket for the build status
[08:26:00.996] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:00.996] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:84:0) after 1m0s
[08:27:01.032] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:84:0)
[08:27:01.032] Timer tick, asking Buildbucket for the build status
[08:27:01.142] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:01.142] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:85:0) after 1m0s
[08:28:01.188] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:85:0)
[08:28:01.188] Timer tick, asking Buildbucket for the build status
[08:28:01.437] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:01.437] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:86:0) after 1m0s
[08:29:01.421] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:86:0)
[08:29:01.421] Timer tick, asking Buildbucket for the build status
[08:29:01.470] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:01.470] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:87:0) after 1m0s
[08:30:01.494] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:87:0)
[08:30:01.494] Timer tick, asking Buildbucket for the build status
[08:30:01.992] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:01.992] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:88:0) after 1m0s
[08:31:02.039] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:88:0)
[08:31:02.039] Timer tick, asking Buildbucket for the build status
[08:31:02.101] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:02.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:89:0) after 1m0s
[08:32:02.125] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:89:0)
[08:32:02.126] Timer tick, asking Buildbucket for the build status
[08:32:02.227] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:02.227] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:90:0) after 1m0s
[08:33:02.247] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:90:0)
[08:33:02.247] Timer tick, asking Buildbucket for the build status
[08:33:02.472] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:02.472] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:91:0) after 1m0s
[08:34:02.587] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:91:0)
[08:34:02.588] Timer tick, asking Buildbucket for the build status
[08:34:02.680] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:02.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:92:0) after 1m0s
[08:35:02.714] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:92:0)
[08:35:02.714] Timer tick, asking Buildbucket for the build status
[08:35:02.920] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:02.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:93:0) after 1m0s
[08:36:02.895] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:93:0)
[08:36:02.895] Timer tick, asking Buildbucket for the build status
[08:36:03.020] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:03.020] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:94:0) after 1m0s
[08:37:02.994] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:94:0)
[08:37:02.994] Timer tick, asking Buildbucket for the build status
[08:37:03.060] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:03.060] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:95:0) after 1m0s
[08:38:03.059] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:95:0)
[08:38:03.059] Timer tick, asking Buildbucket for the build status
[08:38:03.261] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:03.261] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:96:0) after 1m0s
[08:39:03.266] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:96:0)
[08:39:03.266] Timer tick, asking Buildbucket for the build status
[08:39:03.401] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:03.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:97:0) after 1m0s
[08:40:03.406] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:97:0)
[08:40:03.406] Timer tick, asking Buildbucket for the build status
[08:40:03.610] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:03.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:98:0) after 1m0s
[08:41:03.632] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:98:0)
[08:41:03.632] Timer tick, asking Buildbucket for the build status
[08:41:03.968] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:03.968] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:99:0) after 1m0s
[08:42:03.957] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:99:0)
[08:42:03.957] Timer tick, asking Buildbucket for the build status
[08:42:03.995] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:03.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:100:0) after 1m0s
[08:43:03.999] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:100:0)
[08:43:03.999] Timer tick, asking Buildbucket for the build status
[08:43:04.086] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:04.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:101:0) after 1m0s
[08:44:04.120] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:101:0)
[08:44:04.120] Timer tick, asking Buildbucket for the build status
[08:44:04.194] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:04.194] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:102:0) after 1m0s
[08:45:04.219] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:102:0)
[08:45:04.219] Timer tick, asking Buildbucket for the build status
[08:45:04.291] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:04.291] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:103:0) after 1m0s
[08:46:04.315] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:103:0)
[08:46:04.315] Timer tick, asking Buildbucket for the build status
[08:46:04.491] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:04.491] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:104:0) after 1m0s
[08:47:04.513] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:104:0)
[08:47:04.513] Timer tick, asking Buildbucket for the build status
[08:47:04.560] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:04.560] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:105:0) after 1m0s
[08:48:04.583] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:105:0)
[08:48:04.583] Timer tick, asking Buildbucket for the build status
[08:48:04.859] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:04.859] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:106:0) after 1m0s
[08:49:04.879] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:106:0)
[08:49:04.879] Timer tick, asking Buildbucket for the build status
[08:49:05.113] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:05.113] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:107:0) after 1m0s
[08:50:05.141] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:107:0)
[08:50:05.141] Timer tick, asking Buildbucket for the build status
[08:50:05.228] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:05.228] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:108:0) after 1m0s
[08:51:05.249] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:108:0)
[08:51:05.249] Timer tick, asking Buildbucket for the build status
[08:51:05.332] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:05.332] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:109:0) after 1m0s
[08:52:05.351] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:109:0)
[08:52:05.351] Timer tick, asking Buildbucket for the build status
[08:52:05.423] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:05.423] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:110:0) after 1m0s
[08:53:05.425] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:110:0)
[08:53:05.425] Timer tick, asking Buildbucket for the build status
[08:53:05.477] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:05.477] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:111:0) after 1m0s
[08:54:05.500] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:111:0)
[08:54:05.500] Timer tick, asking Buildbucket for the build status
[08:54:05.572] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:05.572] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:112:0) after 1m0s
[08:55:05.591] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:112:0)
[08:55:05.591] Timer tick, asking Buildbucket for the build status
[08:55:05.654] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:05.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:113:0) after 1m0s
[08:56:05.677] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:113:0)
[08:56:05.677] Timer tick, asking Buildbucket for the build status
[08:56:05.808] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:05.808] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:114:0) after 1m0s
[08:57:05.832] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:114:0)
[08:57:05.832] Timer tick, asking Buildbucket for the build status
[08:57:05.901] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:05.901] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:115:0) after 1m0s
[08:58:05.927] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:115:0)
[08:58:05.927] Timer tick, asking Buildbucket for the build status
[08:58:05.970] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:05.970] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:116:0) after 1m0s
[08:59:05.985] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:116:0)
[08:59:05.985] Timer tick, asking Buildbucket for the build status
[08:59:06.066] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:06.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:117:0) after 1m0s
[09:00:06.088] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:117:0)
[09:00:06.088] Timer tick, asking Buildbucket for the build status
[09:00:06.137] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:06.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:118:0) after 1m0s
[09:01:06.118] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:118:0)
[09:01:06.118] Timer tick, asking Buildbucket for the build status
[09:01:06.215] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:06.215] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:119:0) after 1m0s
[09:02:06.247] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:119:0)
[09:02:06.248] Timer tick, asking Buildbucket for the build status
[09:02:06.387] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:06.387] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:120:0) after 1m0s
[09:03:06.424] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:120:0)
[09:03:06.424] Timer tick, asking Buildbucket for the build status
[09:03:06.772] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:06.772] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:121:0) after 1m0s
[09:04:06.803] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:121:0)
[09:04:06.803] Timer tick, asking Buildbucket for the build status
[09:04:07.163] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:07.163] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:122:0) after 1m0s
[09:05:07.182] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:122:0)
[09:05:07.182] Timer tick, asking Buildbucket for the build status
[09:05:07.256] Build 8919120695534351360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:07.256] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084550757677714064:123:0) after 1m0s
[09:05:25.137] Received PubSub notification, asking Buildbucket for the build status
[09:05:25.179] Build 8919120695534351360: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[09:05:25.179] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "AUTO",
"completed_ts": "1552467924269499",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552460689949751",
"failure_reason": "BUILD_FAILURE",
"id": "8919120695534351360",
"parameters_json": "{\"builder_name\": \"clang\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"revision\": \"09ebdc03fefb4c9d61128311066cca632d8e1053\"}}",
"project": "fuchsia",
"result": "FAILURE",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"], \"inside_docker\": [\"0\"], \"locale\": [\"en_US.UTF-8\"], \"image\": [\"fuchsia-debian-9-drawfork-v20181107-ee01d6c\"], \"kvm\": [\"1\"], \"cpu\": [\"x64\", \"x86\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4181-8ab1a58\"], \"machine_type\": [\"n1-standard-1\"], \"gpu\": [\"none\"], \"cores\": [\"1\"], \"os\": [\"Debian\", \"Debian-9.5\", \"Linux\"], \"id\": [\"fuchsia-debian-1-03c1d9de-us-central1-c-ccpn\"], \"pool\": [\"luci.fuchsia.prod\"]}}, \"ui\": {\"info\": \"Failure buildbucket.run\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"timeout\": 7200.0, \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"buildername\": \"clang\", \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"recipe\": \"buildbucket_trigger\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"bot_id\": \"fuchsia-debian-1-03c1d9de-us-central1-c-ccpn\", \"builders\": [\"clang-linux-arm64\", \"clang-linux-x64\", \"clang-mac-x64\"], \"revision\": \"09ebdc03fefb4c9d61128311066cca632d8e1053\"}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1552460695135264",
"status": "COMPLETED",
"status_changed_ts": "1552467924847150",
"tags": [
"builder:clang",
"buildset:commit/git/09ebdc03fefb4c9d61128311066cca632d8e1053",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/09ebdc03fefb4c9d61128311066cca632d8e1053",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9084550757677714064",
"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/8919120695534351360/+/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:438eafbba289b910",
"user_agent:luci-scheduler"
],
"updated_ts": "1552467924853728",
"url": "https://ci.chromium.org/b/8919120695534351360",
"utcnow_ts": "1552467925167841"
}
}
[09:05:25.179] Invocation finished in 2h0m36.657795546s with status FAILED