[05:13:38.207] New invocation is queued and will start shortly
[05:13:39.326] Starting the invocation (attempt 1)
[05:13:39.358] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:13:39.358] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:13:39.358] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9084467155058303376",
"parameters_json": "{\"builder_name\":\"clang\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://fuchsia.googlesource.com/third_party/llvm-project\",\"revision\":\"07f8daf05ed1c6817a02ef89811c955874222245\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:clang",
"scheduler_invocation_id:9084467155058303376",
"scheduler_job_id:fuchsia/prod-clang",
"user_agent:luci-scheduler",
"buildset:commit/git/07f8daf05ed1c6817a02ef89811c955874222245",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/07f8daf05ed1c6817a02ef89811c955874222245",
"gitiles_ref:refs/heads/master"
]
}
[05:13:40.608] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552540419475363",
"id": "8919037093066349728",
"lease_expiration_ts": "1552666420135474",
"lease_key": "2087124549",
"parameters_json": "{\"builder_name\": \"clang\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"revision\": \"07f8daf05ed1c6817a02ef89811c955874222245\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1552540420365684",
"tags": [
"builder:clang",
"buildset:commit/git/07f8daf05ed1c6817a02ef89811c955874222245",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/07f8daf05ed1c6817a02ef89811c955874222245",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9084467155058303376",
"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/8919037093066349728/+/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:4393704f45ed8110",
"user_agent:luci-scheduler"
],
"updated_ts": "1552540420365797",
"url": "https://ci.chromium.org/b/8919037093066349728",
"utcnow_ts": "1552540420592668"
}
}
[05:13:40.608] Task URL: https://ci.chromium.org/b/8919037093066349728
[05:13:40.608] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:2:0) after 1m0s
[05:13:52.102] Received PubSub notification, asking Buildbucket for the build status
[05:13:52.157] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:40.629] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:2:0)
[05:14:40.629] Timer tick, asking Buildbucket for the build status
[05:14:40.690] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:40.690] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:4:0) after 1m0s
[05:15:40.702] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:4:0)
[05:15:40.702] Timer tick, asking Buildbucket for the build status
[05:15:40.952] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:40.952] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:5:0) after 1m0s
[05:16:40.923] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:5:0)
[05:16:40.923] Timer tick, asking Buildbucket for the build status
[05:16:40.988] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:40.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:6:0) after 1m0s
[05:17:40.970] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:6:0)
[05:17:40.970] Timer tick, asking Buildbucket for the build status
[05:17:41.176] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:41.176] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:7:0) after 1m0s
[05:18:41.200] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:7:0)
[05:18:41.200] Timer tick, asking Buildbucket for the build status
[05:18:41.306] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:41.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:8:0) after 1m0s
[05:19:41.325] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:8:0)
[05:19:41.325] Timer tick, asking Buildbucket for the build status
[05:19:41.382] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:41.382] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:9:0) after 1m0s
[05:20:41.406] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:9:0)
[05:20:41.406] Timer tick, asking Buildbucket for the build status
[05:20:41.601] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:41.601] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:10:0) after 1m0s
[05:21:41.595] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:10:0)
[05:21:41.595] Timer tick, asking Buildbucket for the build status
[05:21:41.862] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:41.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:11:0) after 1m0s
[05:22:41.891] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:11:0)
[05:22:41.891] Timer tick, asking Buildbucket for the build status
[05:22:41.964] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:41.964] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:12:0) after 1m0s
[05:23:41.971] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:12:0)
[05:23:41.971] Timer tick, asking Buildbucket for the build status
[05:23:42.050] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:42.050] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:13:0) after 1m0s
[05:24:42.045] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:13:0)
[05:24:42.045] Timer tick, asking Buildbucket for the build status
[05:24:42.199] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:42.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:14:0) after 1m0s
[05:25:42.191] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:14:0)
[05:25:42.191] Timer tick, asking Buildbucket for the build status
[05:25:42.275] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:42.275] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:15:0) after 1m0s
[05:26:42.268] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:15:0)
[05:26:42.268] Timer tick, asking Buildbucket for the build status
[05:26:42.391] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:42.391] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:16:0) after 1m0s
[05:27:42.406] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:16:0)
[05:27:42.406] Timer tick, asking Buildbucket for the build status
[05:27:42.602] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:42.602] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:17:0) after 1m0s
[05:28:42.618] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:17:0)
[05:28:42.618] Timer tick, asking Buildbucket for the build status
[05:28:42.666] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:42.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:18:0) after 1m0s
[05:29:42.708] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:18:0)
[05:29:42.708] Timer tick, asking Buildbucket for the build status
[05:29:42.774] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:42.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:19:0) after 1m0s
[05:30:42.782] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:19:0)
[05:30:42.782] Timer tick, asking Buildbucket for the build status
[05:30:42.897] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:42.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:20:0) after 1m0s
[05:31:42.881] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:20:0)
[05:31:42.881] Timer tick, asking Buildbucket for the build status
[05:31:42.939] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:42.939] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:21:0) after 1m0s
[05:32:42.911] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:21:0)
[05:32:42.911] Timer tick, asking Buildbucket for the build status
[05:32:42.980] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:42.980] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:22:0) after 1m0s
[05:33:42.979] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:22:0)
[05:33:42.979] Timer tick, asking Buildbucket for the build status
[05:33:43.062] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:43.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:23:0) after 1m0s
[05:34:43.090] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:23:0)
[05:34:43.090] Timer tick, asking Buildbucket for the build status
[05:34:43.188] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:43.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:24:0) after 1m0s
[05:35:43.194] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:24:0)
[05:35:43.194] Timer tick, asking Buildbucket for the build status
[05:35:43.283] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:43.283] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:25:0) after 1m0s
[05:36:43.303] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:25:0)
[05:36:43.303] Timer tick, asking Buildbucket for the build status
[05:36:43.383] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:43.383] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:26:0) after 1m0s
[05:37:43.403] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:26:0)
[05:37:43.403] Timer tick, asking Buildbucket for the build status
[05:37:43.464] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:43.464] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:27:0) after 1m0s
[05:38:43.556] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:27:0)
[05:38:43.556] Timer tick, asking Buildbucket for the build status
[05:38:43.621] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:43.621] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:28:0) after 1m0s
[05:39:43.613] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:28:0)
[05:39:43.613] Timer tick, asking Buildbucket for the build status
[05:39:43.682] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:43.682] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:29:0) after 1m0s
[05:40:43.693] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:29:0)
[05:40:43.693] Timer tick, asking Buildbucket for the build status
[05:40:43.755] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:43.755] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:30:0) after 1m0s
[05:41:43.728] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:30:0)
[05:41:43.728] Timer tick, asking Buildbucket for the build status
[05:41:43.815] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:43.815] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:31:0) after 1m0s
[05:42:43.827] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:31:0)
[05:42:43.827] Timer tick, asking Buildbucket for the build status
[05:42:43.986] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:43.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:32:0) after 1m0s
[05:43:44.009] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:32:0)
[05:43:44.009] Timer tick, asking Buildbucket for the build status
[05:43:44.076] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:44.076] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:33:0) after 1m0s
[05:44:44.101] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:33:0)
[05:44:44.101] Timer tick, asking Buildbucket for the build status
[05:44:44.162] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:44.162] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:34:0) after 1m0s
[05:45:44.183] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:34:0)
[05:45:44.183] Timer tick, asking Buildbucket for the build status
[05:45:44.247] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:44.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:35:0) after 1m0s
[05:46:44.264] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:35:0)
[05:46:44.264] Timer tick, asking Buildbucket for the build status
[05:46:44.489] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:44.489] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:36:0) after 1m0s
[05:47:44.507] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:36:0)
[05:47:44.507] Timer tick, asking Buildbucket for the build status
[05:47:44.680] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:44.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:37:0) after 1m0s
[05:48:44.700] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:37:0)
[05:48:44.700] Timer tick, asking Buildbucket for the build status
[05:48:44.865] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:44.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:38:0) after 1m0s
[05:49:44.885] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:38:0)
[05:49:44.885] Timer tick, asking Buildbucket for the build status
[05:49:44.962] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:44.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:39:0) after 1m0s
[05:50:44.980] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:39:0)
[05:50:44.980] Timer tick, asking Buildbucket for the build status
[05:50:45.108] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:45.108] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:40:0) after 1m0s
[05:51:45.101] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:40:0)
[05:51:45.101] Timer tick, asking Buildbucket for the build status
[05:51:45.175] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:45.175] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:41:0) after 1m0s
[05:52:45.195] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:41:0)
[05:52:45.195] Timer tick, asking Buildbucket for the build status
[05:52:45.260] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:45.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:42:0) after 1m0s
[05:53:45.280] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:42:0)
[05:53:45.280] Timer tick, asking Buildbucket for the build status
[05:53:45.384] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:45.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:43:0) after 1m0s
[05:54:45.403] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:43:0)
[05:54:45.403] Timer tick, asking Buildbucket for the build status
[05:54:45.582] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:45.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:44:0) after 1m0s
[05:55:45.612] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:44:0)
[05:55:45.612] Timer tick, asking Buildbucket for the build status
[05:55:45.677] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:45.677] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:45:0) after 1m0s
[05:56:45.681] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:45:0)
[05:56:45.681] Timer tick, asking Buildbucket for the build status
[05:56:45.978] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:45.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:46:0) after 1m0s
[05:57:45.996] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:46:0)
[05:57:45.996] Timer tick, asking Buildbucket for the build status
[05:57:46.092] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:46.092] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:47:0) after 1m0s
[05:58:46.094] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:47:0)
[05:58:46.094] Timer tick, asking Buildbucket for the build status
[05:58:46.150] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:46.150] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:48:0) after 1m0s
[05:59:46.168] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:48:0)
[05:59:46.168] Timer tick, asking Buildbucket for the build status
[05:59:46.242] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:46.242] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:49:0) after 1m0s
[06:00:46.262] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:49:0)
[06:00:46.262] Timer tick, asking Buildbucket for the build status
[06:00:46.379] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:46.379] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:50:0) after 1m0s
[06:01:46.368] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:50:0)
[06:01:46.368] Timer tick, asking Buildbucket for the build status
[06:01:46.431] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:46.431] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:51:0) after 1m0s
[06:02:46.485] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:51:0)
[06:02:46.485] Timer tick, asking Buildbucket for the build status
[06:02:46.564] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:46.564] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:52:0) after 1m0s
[06:03:46.542] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:52:0)
[06:03:46.542] Timer tick, asking Buildbucket for the build status
[06:03:46.629] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:46.629] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:53:0) after 1m0s
[06:04:46.610] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:53:0)
[06:04:46.610] Timer tick, asking Buildbucket for the build status
[06:04:46.855] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:46.855] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:54:0) after 1m0s
[06:05:46.880] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:54:0)
[06:05:46.880] Timer tick, asking Buildbucket for the build status
[06:05:46.953] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:46.953] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:55:0) after 1m0s
[06:06:46.959] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:55:0)
[06:06:46.959] Timer tick, asking Buildbucket for the build status
[06:06:47.088] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:47.088] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:56:0) after 1m0s
[06:07:47.088] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:56:0)
[06:07:47.088] Timer tick, asking Buildbucket for the build status
[06:07:47.156] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:47.156] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:57:0) after 1m0s
[06:08:47.178] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:57:0)
[06:08:47.178] Timer tick, asking Buildbucket for the build status
[06:08:47.449] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:47.449] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:58:0) after 1m0s
[06:09:47.470] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:58:0)
[06:09:47.470] Timer tick, asking Buildbucket for the build status
[06:09:47.565] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:47.565] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:59:0) after 1m0s
[06:10:47.558] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:59:0)
[06:10:47.558] Timer tick, asking Buildbucket for the build status
[06:10:47.699] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:47.699] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:60:0) after 1m0s
[06:11:47.704] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:60:0)
[06:11:47.704] Timer tick, asking Buildbucket for the build status
[06:11:47.868] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:47.868] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:61:0) after 1m0s
[06:12:47.889] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:61:0)
[06:12:47.889] Timer tick, asking Buildbucket for the build status
[06:12:47.997] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:47.997] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:62:0) after 1m0s
[06:13:48.058] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:62:0)
[06:13:48.058] Timer tick, asking Buildbucket for the build status
[06:13:48.129] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:48.129] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:63:0) after 1m0s
[06:14:48.224] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:63:0)
[06:14:48.224] Timer tick, asking Buildbucket for the build status
[06:14:48.500] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:48.500] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:64:0) after 1m0s
[06:15:48.497] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:64:0)
[06:15:48.497] Timer tick, asking Buildbucket for the build status
[06:15:48.570] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:48.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:65:0) after 1m0s
[06:16:48.589] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:65:0)
[06:16:48.589] Timer tick, asking Buildbucket for the build status
[06:16:48.858] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:48.858] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:66:0) after 1m0s
[06:17:48.891] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:66:0)
[06:17:48.891] Timer tick, asking Buildbucket for the build status
[06:17:48.952] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:48.952] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:67:0) after 1m0s
[06:18:48.936] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:67:0)
[06:18:48.936] Timer tick, asking Buildbucket for the build status
[06:18:49.166] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:49.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:68:0) after 1m0s
[06:19:49.185] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:68:0)
[06:19:49.185] Timer tick, asking Buildbucket for the build status
[06:19:49.287] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:49.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:69:0) after 1m0s
[06:20:49.311] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:69:0)
[06:20:49.311] Timer tick, asking Buildbucket for the build status
[06:20:49.452] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:49.452] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:70:0) after 1m0s
[06:21:49.469] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:70:0)
[06:21:49.469] Timer tick, asking Buildbucket for the build status
[06:21:49.774] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:49.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:71:0) after 1m0s
[06:22:49.761] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:71:0)
[06:22:49.761] Timer tick, asking Buildbucket for the build status
[06:22:49.888] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:49.888] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:72:0) after 1m0s
[06:23:49.910] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:72:0)
[06:23:49.910] Timer tick, asking Buildbucket for the build status
[06:23:49.971] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:49.971] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:73:0) after 1m0s
[06:24:49.989] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:73:0)
[06:24:49.989] Timer tick, asking Buildbucket for the build status
[06:24:50.096] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:50.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:74:0) after 1m0s
[06:25:50.078] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:74:0)
[06:25:50.078] Timer tick, asking Buildbucket for the build status
[06:25:50.252] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:50.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:75:0) after 1m0s
[06:26:50.273] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:75:0)
[06:26:50.273] Timer tick, asking Buildbucket for the build status
[06:26:50.337] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:50.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:76:0) after 1m0s
[06:27:50.337] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:76:0)
[06:27:50.337] Timer tick, asking Buildbucket for the build status
[06:27:50.400] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:50.400] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:77:0) after 1m0s
[06:28:50.411] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:77:0)
[06:28:50.411] Timer tick, asking Buildbucket for the build status
[06:28:50.457] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:50.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:78:0) after 1m0s
[06:29:50.480] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:78:0)
[06:29:50.480] Timer tick, asking Buildbucket for the build status
[06:29:50.595] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:50.595] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:79:0) after 1m0s
[06:30:50.617] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:79:0)
[06:30:50.617] Timer tick, asking Buildbucket for the build status
[06:30:50.660] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:50.660] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:80:0) after 1m0s
[06:31:50.647] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:80:0)
[06:31:50.647] Timer tick, asking Buildbucket for the build status
[06:31:50.714] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:50.714] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:81:0) after 1m0s
[06:32:50.706] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:81:0)
[06:32:50.706] Timer tick, asking Buildbucket for the build status
[06:32:50.791] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:50.791] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:82:0) after 1m0s
[06:33:50.813] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:82:0)
[06:33:50.813] Timer tick, asking Buildbucket for the build status
[06:33:51.102] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:51.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:83:0) after 1m0s
[06:34:51.193] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:83:0)
[06:34:51.193] Timer tick, asking Buildbucket for the build status
[06:34:51.256] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:51.256] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:84:0) after 1m0s
[06:35:51.277] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:84:0)
[06:35:51.277] Timer tick, asking Buildbucket for the build status
[06:35:51.317] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:51.317] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:85:0) after 1m0s
[06:36:51.321] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:85:0)
[06:36:51.321] Timer tick, asking Buildbucket for the build status
[06:36:51.379] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:51.379] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:86:0) after 1m0s
[06:37:51.382] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:86:0)
[06:37:51.382] Timer tick, asking Buildbucket for the build status
[06:37:51.611] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:51.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:87:0) after 1m0s
[06:38:51.631] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:87:0)
[06:38:51.631] Timer tick, asking Buildbucket for the build status
[06:38:51.779] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:51.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:88:0) after 1m0s
[06:39:51.800] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:88:0)
[06:39:51.800] Timer tick, asking Buildbucket for the build status
[06:39:51.859] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:51.859] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:89:0) after 1m0s
[06:40:51.869] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:89:0)
[06:40:51.869] Timer tick, asking Buildbucket for the build status
[06:40:51.919] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:51.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:90:0) after 1m0s
[06:41:51.941] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:90:0)
[06:41:51.941] Timer tick, asking Buildbucket for the build status
[06:41:52.102] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:52.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:91:0) after 1m0s
[06:42:52.111] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:91:0)
[06:42:52.111] Timer tick, asking Buildbucket for the build status
[06:42:52.301] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:52.301] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:92:0) after 1m0s
[06:43:52.324] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:92:0)
[06:43:52.324] Timer tick, asking Buildbucket for the build status
[06:43:52.389] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:52.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:93:0) after 1m0s
[06:44:52.366] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:93:0)
[06:44:52.366] Timer tick, asking Buildbucket for the build status
[06:44:52.570] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:52.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:94:0) after 1m0s
[06:45:52.592] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:94:0)
[06:45:52.592] Timer tick, asking Buildbucket for the build status
[06:45:52.797] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:52.797] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:95:0) after 1m0s
[06:46:52.779] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:95:0)
[06:46:52.779] Timer tick, asking Buildbucket for the build status
[06:46:52.838] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:52.838] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:96:0) after 1m0s
[06:47:52.861] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:96:0)
[06:47:52.861] Timer tick, asking Buildbucket for the build status
[06:47:53.088] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:53.088] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:97:0) after 1m0s
[06:48:53.096] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:97:0)
[06:48:53.096] Timer tick, asking Buildbucket for the build status
[06:48:53.362] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:53.362] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:98:0) after 1m0s
[06:49:53.385] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:98:0)
[06:49:53.385] Timer tick, asking Buildbucket for the build status
[06:49:53.452] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:53.452] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:99:0) after 1m0s
[06:50:53.483] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:99:0)
[06:50:53.483] Timer tick, asking Buildbucket for the build status
[06:50:53.554] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:53.554] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:100:0) after 1m0s
[06:51:53.566] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:100:0)
[06:51:53.566] Timer tick, asking Buildbucket for the build status
[06:51:53.629] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:53.629] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:101:0) after 1m0s
[06:52:53.669] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:101:0)
[06:52:53.669] Timer tick, asking Buildbucket for the build status
[06:52:53.727] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:53.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:102:0) after 1m0s
[06:53:53.731] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:102:0)
[06:53:53.731] Timer tick, asking Buildbucket for the build status
[06:53:53.858] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:53.858] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:103:0) after 1m0s
[06:54:53.883] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:103:0)
[06:54:53.883] Timer tick, asking Buildbucket for the build status
[06:54:53.946] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:53.946] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:104:0) after 1m0s
[06:55:53.938] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:104:0)
[06:55:53.938] Timer tick, asking Buildbucket for the build status
[06:55:54.086] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:54.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:105:0) after 1m0s
[06:56:54.115] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:105:0)
[06:56:54.115] Timer tick, asking Buildbucket for the build status
[06:56:54.177] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:54.177] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:106:0) after 1m0s
[06:57:54.224] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:106:0)
[06:57:54.224] Timer tick, asking Buildbucket for the build status
[06:57:54.286] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:54.286] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:107:0) after 1m0s
[06:58:54.276] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:107:0)
[06:58:54.276] Timer tick, asking Buildbucket for the build status
[06:58:54.408] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:54.408] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:108:0) after 1m0s
[06:59:54.421] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:108:0)
[06:59:54.421] Timer tick, asking Buildbucket for the build status
[06:59:54.505] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:54.505] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:109:0) after 1m0s
[07:00:54.492] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:109:0)
[07:00:54.492] Timer tick, asking Buildbucket for the build status
[07:00:54.883] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:54.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:110:0) after 1m0s
[07:01:54.878] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:110:0)
[07:01:54.878] Timer tick, asking Buildbucket for the build status
[07:01:54.944] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:54.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:111:0) after 1m0s
[07:02:54.969] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:111:0)
[07:02:54.969] Timer tick, asking Buildbucket for the build status
[07:02:55.089] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:55.089] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:112:0) after 1m0s
[07:03:55.123] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:112:0)
[07:03:55.123] Timer tick, asking Buildbucket for the build status
[07:03:55.246] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:55.246] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:113:0) after 1m0s
[07:04:55.267] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:113:0)
[07:04:55.267] Timer tick, asking Buildbucket for the build status
[07:04:55.679] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:55.679] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:114:0) after 1m0s
[07:05:55.701] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:114:0)
[07:05:55.701] Timer tick, asking Buildbucket for the build status
[07:05:55.774] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:55.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:115:0) after 1m0s
[07:06:55.796] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:115:0)
[07:06:55.796] Timer tick, asking Buildbucket for the build status
[07:06:55.866] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:55.866] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:116:0) after 1m0s
[07:07:55.893] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:116:0)
[07:07:55.893] Timer tick, asking Buildbucket for the build status
[07:07:56.008] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:56.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:117:0) after 1m0s
[07:08:56.095] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:117:0)
[07:08:56.095] Timer tick, asking Buildbucket for the build status
[07:08:56.163] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:56.163] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:118:0) after 1m0s
[07:09:56.187] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:118:0)
[07:09:56.187] Timer tick, asking Buildbucket for the build status
[07:09:56.308] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:56.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:119:0) after 1m0s
[07:10:56.336] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:119:0)
[07:10:56.336] Timer tick, asking Buildbucket for the build status
[07:10:56.472] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:56.472] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:120:0) after 1m0s
[07:11:56.472] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:120:0)
[07:11:56.472] Timer tick, asking Buildbucket for the build status
[07:11:56.529] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:56.529] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:121:0) after 1m0s
[07:12:56.576] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:121:0)
[07:12:56.576] Timer tick, asking Buildbucket for the build status
[07:12:56.729] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:56.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:122:0) after 1m0s
[07:13:56.737] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:122:0)
[07:13:56.737] Timer tick, asking Buildbucket for the build status
[07:13:56.795] Build 8919037093066349728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:56.795] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9084467155058303376:123:0) after 1m0s
[07:14:22.748] Received PubSub notification, asking Buildbucket for the build status
[07:14:22.797] Build 8919037093066349728: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[07:14:22.797] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "AUTO",
"completed_ts": "1552547661893900",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552540419475363",
"failure_reason": "BUILD_FAILURE",
"id": "8919037093066349728",
"parameters_json": "{\"builder_name\": \"clang\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"revision\": \"07f8daf05ed1c6817a02ef89811c955874222245\"}}",
"project": "fuchsia",
"result": "FAILURE",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"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\": [\"4186-af94c3f\"], \"machine_type\": [\"n1-standard-1\"], \"gpu\": [\"none\"], \"cores\": [\"1\"], \"os\": [\"Debian\", \"Debian-9.5\", \"Linux\"], \"id\": [\"fuchsia-debian-1-03c1d9de-us-central1-b-qll7\"], \"pool\": [\"luci.fuchsia.prod\"], \"caches\": [\"vpython\"]}}, \"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\"}, \"branch\": \"refs/heads/master\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"buildername\": \"clang\", \"builders\": [\"clang-linux-arm64\", \"clang-linux-x64\", \"clang-mac-x64\"], \"recipe\": \"buildbucket_trigger\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"timeout\": 7200.0, \"path_config\": \"generic\", \"bot_id\": \"fuchsia-debian-1-03c1d9de-us-central1-b-qll7\", \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"revision\": \"07f8daf05ed1c6817a02ef89811c955874222245\"}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1552540431459612",
"status": "COMPLETED",
"status_changed_ts": "1552547662405644",
"tags": [
"builder:clang",
"buildset:commit/git/07f8daf05ed1c6817a02ef89811c955874222245",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/07f8daf05ed1c6817a02ef89811c955874222245",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9084467155058303376",
"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/8919037093066349728/+/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:4393704f45ed8110",
"user_agent:luci-scheduler"
],
"updated_ts": "1552547662409573",
"url": "https://ci.chromium.org/b/8919037093066349728",
"utcnow_ts": "1552547662787891"
}
}
[07:14:22.797] Invocation finished in 2h0m44.605530005s with status FAILED