[01:28:52.082] New invocation is queued and will start shortly
[01:28:53.169] Starting the invocation (attempt 1)
[01:28:53.243] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:28:53.243] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:28:53.243] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9080132641901052384",
"parameters_json": "{\"builder_name\":\"clang\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://fuchsia.googlesource.com/third_party/llvm-project\",\"revision\":\"db555ab4df0e7ba02618070cd1e80d55a9baa453\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:clang",
"scheduler_invocation_id:9080132641901052384",
"scheduler_job_id:fuchsia/prod-clang",
"user_agent:luci-scheduler",
"buildset:commit/git/db555ab4df0e7ba02618070cd1e80d55a9baa453",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/db555ab4df0e7ba02618070cd1e80d55a9baa453",
"gitiles_ref:refs/heads/master"
]
}
[01:28:53.933] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "AUTO",
"created_by": "project:fuchsia",
"created_ts": "1556674133348002",
"id": "8914702579908508656",
"parameters_json": "{\"builder_name\": \"clang\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"revision\": \"db555ab4df0e7ba02618070cd1e80d55a9baa453\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1556674133644925",
"tags": [
"builder:clang",
"buildset:commit/git/db555ab4df0e7ba02618070cd1e80d55a9baa453",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/db555ab4df0e7ba02618070cd1e80d55a9baa453",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9080132641901052384",
"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/8914702579908508656/+/annotations",
"swarming_tag:luci_project:fuchsia",
"swarming_tag:recipe_name:buildbucket_trigger",
"swarming_tag:recipe_package:fuchsia/infra/recipe_bundles/fuchsia.googlesource.com/infra/recipes",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1556674133645035",
"url": "https://ci.chromium.org/b/8914702579908508656",
"utcnow_ts": "1556674133923796"
}
}
[01:28:53.933] Task URL: https://ci.chromium.org/b/8914702579908508656
[01:28:53.933] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:2:0) after 1m0s
[01:28:56.486] Received PubSub notification, asking Buildbucket for the build status
[01:28:56.533] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:53.960] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:2:0)
[01:29:53.960] Timer tick, asking Buildbucket for the build status
[01:29:54.161] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:54.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:4:0) after 1m0s
[01:30:54.191] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:4:0)
[01:30:54.191] Timer tick, asking Buildbucket for the build status
[01:30:54.242] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:54.242] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:5:0) after 1m0s
[01:31:54.283] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:5:0)
[01:31:54.283] Timer tick, asking Buildbucket for the build status
[01:31:54.367] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:54.367] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:6:0) after 1m0s
[01:32:54.386] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:6:0)
[01:32:54.386] Timer tick, asking Buildbucket for the build status
[01:32:54.497] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:54.497] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:7:0) after 1m0s
[01:33:54.479] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:7:0)
[01:33:54.479] Timer tick, asking Buildbucket for the build status
[01:33:54.536] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:54.536] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:8:0) after 1m0s
[01:34:54.545] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:8:0)
[01:34:54.545] Timer tick, asking Buildbucket for the build status
[01:34:54.608] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:54.608] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:9:0) after 1m0s
[01:35:54.630] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:9:0)
[01:35:54.630] Timer tick, asking Buildbucket for the build status
[01:35:54.753] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:54.753] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:10:0) after 1m0s
[01:36:54.730] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:10:0)
[01:36:54.730] Timer tick, asking Buildbucket for the build status
[01:36:54.768] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:54.768] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:11:0) after 1m0s
[01:37:54.805] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:11:0)
[01:37:54.805] Timer tick, asking Buildbucket for the build status
[01:37:54.988] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:54.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:12:0) after 1m0s
[01:38:54.986] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:12:0)
[01:38:54.986] Timer tick, asking Buildbucket for the build status
[01:38:55.087] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:55.087] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:13:0) after 1m0s
[01:39:55.105] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:13:0)
[01:39:55.105] Timer tick, asking Buildbucket for the build status
[01:39:55.189] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:55.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:14:0) after 1m0s
[01:40:55.172] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:14:0)
[01:40:55.172] Timer tick, asking Buildbucket for the build status
[01:40:55.211] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:55.212] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:15:0) after 1m0s
[01:41:55.192] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:15:0)
[01:41:55.192] Timer tick, asking Buildbucket for the build status
[01:41:55.229] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:55.229] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:16:0) after 1m0s
[01:42:55.211] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:16:0)
[01:42:55.211] Timer tick, asking Buildbucket for the build status
[01:42:55.407] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:55.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:17:0) after 1m0s
[01:43:55.424] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:17:0)
[01:43:55.424] Timer tick, asking Buildbucket for the build status
[01:43:55.557] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:55.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:18:0) after 1m0s
[01:44:55.560] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:18:0)
[01:44:55.560] Timer tick, asking Buildbucket for the build status
[01:44:55.625] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:55.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:19:0) after 1m0s
[01:45:55.645] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:19:0)
[01:45:55.645] Timer tick, asking Buildbucket for the build status
[01:45:55.690] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:55.690] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:20:0) after 1m0s
[01:46:55.708] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:20:0)
[01:46:55.708] Timer tick, asking Buildbucket for the build status
[01:46:55.796] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:55.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:21:0) after 1m0s
[01:47:55.867] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:21:0)
[01:47:55.867] Timer tick, asking Buildbucket for the build status
[01:47:56.011] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:56.011] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:22:0) after 1m0s
[01:48:56.048] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:22:0)
[01:48:56.048] Timer tick, asking Buildbucket for the build status
[01:48:56.215] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:56.215] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:23:0) after 1m0s
[01:49:56.250] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:23:0)
[01:49:56.250] Timer tick, asking Buildbucket for the build status
[01:49:56.388] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:56.388] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:24:0) after 1m0s
[01:50:56.410] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:24:0)
[01:50:56.410] Timer tick, asking Buildbucket for the build status
[01:50:56.466] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:56.466] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:25:0) after 1m0s
[01:51:56.451] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:25:0)
[01:51:56.451] Timer tick, asking Buildbucket for the build status
[01:51:56.501] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:56.501] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:26:0) after 1m0s
[01:52:56.520] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:26:0)
[01:52:56.520] Timer tick, asking Buildbucket for the build status
[01:52:56.578] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:56.578] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:27:0) after 1m0s
[01:53:56.600] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:27:0)
[01:53:56.600] Timer tick, asking Buildbucket for the build status
[01:53:56.693] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:56.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:28:0) after 1m0s
[01:54:56.693] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:28:0)
[01:54:56.693] Timer tick, asking Buildbucket for the build status
[01:54:56.749] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:56.749] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:29:0) after 1m0s
[01:55:56.778] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:29:0)
[01:55:56.778] Timer tick, asking Buildbucket for the build status
[01:55:56.819] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:56.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:30:0) after 1m0s
[01:56:56.839] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:30:0)
[01:56:56.839] Timer tick, asking Buildbucket for the build status
[01:56:56.902] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:56.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:31:0) after 1m0s
[01:57:56.924] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:31:0)
[01:57:56.924] Timer tick, asking Buildbucket for the build status
[01:57:56.962] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:56.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:32:0) after 1m0s
[01:58:56.981] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:32:0)
[01:58:56.981] Timer tick, asking Buildbucket for the build status
[01:58:57.039] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:57.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:33:0) after 1m0s
[01:59:57.051] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:33:0)
[01:59:57.051] Timer tick, asking Buildbucket for the build status
[01:59:57.110] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:57.110] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:34:0) after 1m0s
[02:00:57.152] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:34:0)
[02:00:57.152] Timer tick, asking Buildbucket for the build status
[02:00:57.248] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:57.248] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:35:0) after 1m0s
[02:01:57.276] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:35:0)
[02:01:57.276] Timer tick, asking Buildbucket for the build status
[02:01:57.332] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:57.332] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:36:0) after 1m0s
[02:02:57.403] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:36:0)
[02:02:57.403] Timer tick, asking Buildbucket for the build status
[02:02:57.676] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:57.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:37:0) after 1m0s
[02:03:57.697] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:37:0)
[02:03:57.697] Timer tick, asking Buildbucket for the build status
[02:03:57.756] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:57.756] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:38:0) after 1m0s
[02:04:57.760] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:38:0)
[02:04:57.760] Timer tick, asking Buildbucket for the build status
[02:04:57.831] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:57.831] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:39:0) after 1m0s
[02:05:57.861] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:39:0)
[02:05:57.861] Timer tick, asking Buildbucket for the build status
[02:05:57.900] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:57.900] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:40:0) after 1m0s
[02:06:57.921] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:40:0)
[02:06:57.921] Timer tick, asking Buildbucket for the build status
[02:06:58.019] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:58.019] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:41:0) after 1m0s
[02:07:58.019] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:41:0)
[02:07:58.019] Timer tick, asking Buildbucket for the build status
[02:07:58.072] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:58.072] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:42:0) after 1m0s
[02:08:58.091] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:42:0)
[02:08:58.091] Timer tick, asking Buildbucket for the build status
[02:08:58.154] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:58.154] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:43:0) after 1m0s
[02:09:58.150] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:43:0)
[02:09:58.150] Timer tick, asking Buildbucket for the build status
[02:09:58.186] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:58.186] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:44:0) after 1m0s
[02:10:58.198] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:44:0)
[02:10:58.198] Timer tick, asking Buildbucket for the build status
[02:10:58.262] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:58.262] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:45:0) after 1m0s
[02:11:58.277] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:45:0)
[02:11:58.277] Timer tick, asking Buildbucket for the build status
[02:11:58.315] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:58.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:46:0) after 1m0s
[02:12:58.346] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:46:0)
[02:12:58.346] Timer tick, asking Buildbucket for the build status
[02:12:58.431] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:58.431] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:47:0) after 1m0s
[02:13:58.455] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:47:0)
[02:13:58.455] Timer tick, asking Buildbucket for the build status
[02:13:58.489] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:58.489] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:48:0) after 1m0s
[02:14:58.512] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:48:0)
[02:14:58.512] Timer tick, asking Buildbucket for the build status
[02:14:58.585] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:58.585] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:49:0) after 1m0s
[02:15:58.693] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:49:0)
[02:15:58.693] Timer tick, asking Buildbucket for the build status
[02:15:58.728] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:58.728] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:50:0) after 1m0s
[02:16:58.749] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:50:0)
[02:16:58.749] Timer tick, asking Buildbucket for the build status
[02:16:59.558] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:59.558] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:51:0) after 1m0s
[02:17:59.565] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:51:0)
[02:17:59.565] Timer tick, asking Buildbucket for the build status
[02:17:59.607] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:59.607] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:52:0) after 1m0s
[02:18:59.627] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:52:0)
[02:18:59.627] Timer tick, asking Buildbucket for the build status
[02:18:59.782] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:59.782] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:53:0) after 1m0s
[02:19:59.803] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:53:0)
[02:19:59.803] Timer tick, asking Buildbucket for the build status
[02:19:59.883] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:59.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:54:0) after 1m0s
[02:20:59.913] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:54:0)
[02:20:59.913] Timer tick, asking Buildbucket for the build status
[02:21:00.013] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:00.013] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:55:0) after 1m0s
[02:22:00.030] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:55:0)
[02:22:00.030] Timer tick, asking Buildbucket for the build status
[02:22:00.250] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:00.250] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:56:0) after 1m0s
[02:23:00.253] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:56:0)
[02:23:00.253] Timer tick, asking Buildbucket for the build status
[02:23:00.323] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:00.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:57:0) after 1m0s
[02:24:00.313] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:57:0)
[02:24:00.313] Timer tick, asking Buildbucket for the build status
[02:24:00.486] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:00.486] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:58:0) after 1m0s
[02:25:00.483] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:58:0)
[02:25:00.483] Timer tick, asking Buildbucket for the build status
[02:25:00.520] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:00.520] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:59:0) after 1m0s
[02:26:00.532] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:59:0)
[02:26:00.532] Timer tick, asking Buildbucket for the build status
[02:26:00.896] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:00.896] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:60:0) after 1m0s
[02:27:00.917] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:60:0)
[02:27:00.917] Timer tick, asking Buildbucket for the build status
[02:27:00.959] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:00.959] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:61:0) after 1m0s
[02:28:00.980] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:61:0)
[02:28:00.980] Timer tick, asking Buildbucket for the build status
[02:28:02.660] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:02.660] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:62:0) after 1m0s
[02:29:02.697] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:62:0)
[02:29:02.697] Timer tick, asking Buildbucket for the build status
[02:29:02.761] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:02.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:63:0) after 1m0s
[02:30:02.781] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:63:0)
[02:30:02.781] Timer tick, asking Buildbucket for the build status
[02:30:02.834] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:02.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:64:0) after 1m0s
[02:31:02.856] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:64:0)
[02:31:02.856] Timer tick, asking Buildbucket for the build status
[02:31:02.921] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:02.921] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:65:0) after 1m0s
[02:32:02.918] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:65:0)
[02:32:02.919] Timer tick, asking Buildbucket for the build status
[02:32:03.223] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:03.223] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:66:0) after 1m0s
[02:33:03.246] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:66:0)
[02:33:03.246] Timer tick, asking Buildbucket for the build status
[02:33:05.500] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:05.500] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:67:0) after 1m0s
[02:34:05.527] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:67:0)
[02:34:05.527] Timer tick, asking Buildbucket for the build status
[02:34:07.896] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:07.896] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:68:0) after 1m0s
[02:35:08.018] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:68:0)
[02:35:08.018] Timer tick, asking Buildbucket for the build status
[02:35:13.713] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:13.713] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:69:0) after 1m0s
[02:36:13.950] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:69:0)
[02:36:13.950] Timer tick, asking Buildbucket for the build status
[02:36:14.016] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:14.016] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:70:0) after 1m0s
[02:37:14.004] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:70:0)
[02:37:14.004] Timer tick, asking Buildbucket for the build status
[02:37:14.091] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:14.091] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:71:0) after 1m0s
[02:38:14.109] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:71:0)
[02:38:14.109] Timer tick, asking Buildbucket for the build status
[02:38:14.168] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:14.168] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:72:0) after 1m0s
[02:39:14.197] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:72:0)
[02:39:14.197] Timer tick, asking Buildbucket for the build status
[02:39:14.279] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:14.279] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:73:0) after 1m0s
[02:40:14.481] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:73:0)
[02:40:14.481] Timer tick, asking Buildbucket for the build status
[02:40:14.551] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:14.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:74:0) after 1m0s
[02:41:14.573] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:74:0)
[02:41:14.573] Timer tick, asking Buildbucket for the build status
[02:41:14.768] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:14.768] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:75:0) after 1m0s
[02:42:14.788] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:75:0)
[02:42:14.788] Timer tick, asking Buildbucket for the build status
[02:42:14.843] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:14.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:76:0) after 1m0s
[02:43:14.866] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:76:0)
[02:43:14.866] Timer tick, asking Buildbucket for the build status
[02:43:14.933] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:14.933] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:77:0) after 1m0s
[02:44:14.917] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:77:0)
[02:44:14.917] Timer tick, asking Buildbucket for the build status
[02:44:14.959] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:14.959] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:78:0) after 1m0s
[02:45:14.983] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:78:0)
[02:45:14.983] Timer tick, asking Buildbucket for the build status
[02:45:15.038] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:15.038] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:79:0) after 1m0s
[02:46:15.053] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:79:0)
[02:46:15.053] Timer tick, asking Buildbucket for the build status
[02:46:15.113] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:15.113] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:80:0) after 1m0s
[02:47:15.135] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:80:0)
[02:47:15.135] Timer tick, asking Buildbucket for the build status
[02:47:15.210] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:15.210] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:81:0) after 1m0s
[02:48:15.248] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:81:0)
[02:48:15.248] Timer tick, asking Buildbucket for the build status
[02:48:15.406] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:15.406] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:82:0) after 1m0s
[02:49:15.503] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:82:0)
[02:49:15.503] Timer tick, asking Buildbucket for the build status
[02:49:15.574] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:15.574] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:83:0) after 1m0s
[02:50:15.618] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:83:0)
[02:50:15.618] Timer tick, asking Buildbucket for the build status
[02:50:15.659] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:15.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:84:0) after 1m0s
[02:51:15.641] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:84:0)
[02:51:15.641] Timer tick, asking Buildbucket for the build status
[02:51:15.963] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:15.963] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:85:0) after 1m0s
[02:52:16.044] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:85:0)
[02:52:16.044] Timer tick, asking Buildbucket for the build status
[02:52:16.192] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:16.192] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:86:0) after 1m0s
[02:53:16.217] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:86:0)
[02:53:16.217] Timer tick, asking Buildbucket for the build status
[02:53:16.324] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:16.324] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:87:0) after 1m0s
[02:54:16.325] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:87:0)
[02:54:16.325] Timer tick, asking Buildbucket for the build status
[02:54:16.381] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:16.381] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:88:0) after 1m0s
[02:55:16.368] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:88:0)
[02:55:16.368] Timer tick, asking Buildbucket for the build status
[02:55:16.431] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:16.431] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:89:0) after 1m0s
[02:56:16.426] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:89:0)
[02:56:16.426] Timer tick, asking Buildbucket for the build status
[02:56:16.516] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:16.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:90:0) after 1m0s
[02:57:16.567] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:90:0)
[02:57:16.567] Timer tick, asking Buildbucket for the build status
[02:57:16.774] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:16.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:91:0) after 1m0s
[02:58:16.764] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:91:0)
[02:58:16.764] Timer tick, asking Buildbucket for the build status
[02:58:16.806] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:16.806] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:92:0) after 1m0s
[02:59:16.853] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:92:0)
[02:59:16.853] Timer tick, asking Buildbucket for the build status
[02:59:16.906] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:16.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:93:0) after 1m0s
[03:00:16.931] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:93:0)
[03:00:16.931] Timer tick, asking Buildbucket for the build status
[03:00:16.973] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:16.973] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:94:0) after 1m0s
[03:01:16.974] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:94:0)
[03:01:16.974] Timer tick, asking Buildbucket for the build status
[03:01:17.037] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:17.037] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:95:0) after 1m0s
[03:02:17.059] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:95:0)
[03:02:17.059] Timer tick, asking Buildbucket for the build status
[03:02:17.102] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:17.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:96:0) after 1m0s
[03:03:17.126] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:96:0)
[03:03:17.127] Timer tick, asking Buildbucket for the build status
[03:03:17.181] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:17.181] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:97:0) after 1m0s
[03:04:17.175] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:97:0)
[03:04:17.175] Timer tick, asking Buildbucket for the build status
[03:04:17.212] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:17.212] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:98:0) after 1m0s
[03:05:17.228] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:98:0)
[03:05:17.228] Timer tick, asking Buildbucket for the build status
[03:05:17.373] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:17.373] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:99:0) after 1m0s
[03:06:17.385] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:99:0)
[03:06:17.385] Timer tick, asking Buildbucket for the build status
[03:06:17.496] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:17.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:100:0) after 1m0s
[03:07:17.474] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:100:0)
[03:07:17.474] Timer tick, asking Buildbucket for the build status
[03:07:17.557] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:17.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:101:0) after 1m0s
[03:08:17.578] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:101:0)
[03:08:17.578] Timer tick, asking Buildbucket for the build status
[03:08:17.646] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:17.646] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:102:0) after 1m0s
[03:09:17.667] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:102:0)
[03:09:17.667] Timer tick, asking Buildbucket for the build status
[03:09:17.710] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:17.710] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:103:0) after 1m0s
[03:10:17.693] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:103:0)
[03:10:17.693] Timer tick, asking Buildbucket for the build status
[03:10:17.864] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:17.864] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:104:0) after 1m0s
[03:11:17.885] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:104:0)
[03:11:17.885] Timer tick, asking Buildbucket for the build status
[03:11:17.984] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:17.984] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:105:0) after 1m0s
[03:12:18.013] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:105:0)
[03:12:18.013] Timer tick, asking Buildbucket for the build status
[03:12:18.358] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:18.358] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:106:0) after 1m0s
[03:13:18.383] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:106:0)
[03:13:18.383] Timer tick, asking Buildbucket for the build status
[03:13:18.497] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:18.497] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:107:0) after 1m0s
[03:14:18.475] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:107:0)
[03:14:18.475] Timer tick, asking Buildbucket for the build status
[03:14:18.543] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:18.543] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:108:0) after 1m0s
[03:15:18.572] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:108:0)
[03:15:18.572] Timer tick, asking Buildbucket for the build status
[03:15:18.665] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:18.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:109:0) after 1m0s
[03:16:18.688] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:109:0)
[03:16:18.688] Timer tick, asking Buildbucket for the build status
[03:16:18.728] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:18.728] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:110:0) after 1m0s
[03:17:18.757] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:110:0)
[03:17:18.757] Timer tick, asking Buildbucket for the build status
[03:17:18.816] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:18.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:111:0) after 1m0s
[03:18:18.810] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:111:0)
[03:18:18.810] Timer tick, asking Buildbucket for the build status
[03:18:18.982] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:18.982] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:112:0) after 1m0s
[03:19:18.981] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:112:0)
[03:19:18.981] Timer tick, asking Buildbucket for the build status
[03:19:19.050] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:19.050] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:113:0) after 1m0s
[03:20:19.038] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:113:0)
[03:20:19.038] Timer tick, asking Buildbucket for the build status
[03:20:19.086] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:19.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:114:0) after 1m0s
[03:21:19.113] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:114:0)
[03:21:19.113] Timer tick, asking Buildbucket for the build status
[03:21:19.191] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:19.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:115:0) after 1m0s
[03:22:19.202] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:115:0)
[03:22:19.202] Timer tick, asking Buildbucket for the build status
[03:22:19.238] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:19.238] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:116:0) after 1m0s
[03:23:19.261] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:116:0)
[03:23:19.261] Timer tick, asking Buildbucket for the build status
[03:23:19.310] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:19.310] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:117:0) after 1m0s
[03:24:19.334] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:117:0)
[03:24:19.334] Timer tick, asking Buildbucket for the build status
[03:24:19.405] Build 8914702579908508656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:19.405] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9080132641901052384:118:0) after 1m0s
[03:24:36.200] Received PubSub notification, asking Buildbucket for the build status
[03:24:36.238] Build 8914702579908508656: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:24:36.238] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "AUTO",
"completed_ts": "1556681075033920",
"created_by": "project:fuchsia",
"created_ts": "1556674133348002",
"id": "8914702579908508656",
"parameters_json": "{\"builder_name\": \"clang\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"revision\": \"db555ab4df0e7ba02618070cd1e80d55a9baa453\"}}",
"project": "fuchsia",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"fuchsia-debian-1-003729e9-us-central1-b-t5fc\", \"branch\": \"refs/heads/master\", \"buildername\": \"clang\", \"builders\": [\"clang-linux-arm64\", \"clang-linux-x64\", \"clang-mac-x64\"], \"path_config\": \"generic\", \"recipe\": \"buildbucket_trigger\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"revision\": \"db555ab4df0e7ba02618070cd1e80d55a9baa453\", \"timeout\": 7200.0}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"vpython\"], \"cores\": [\"1\"], \"cpu\": [\"x64\", \"x86\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"fuchsia-debian-1-003729e9-us-central1-b-t5fc\"], \"image\": [\"fuchsia-debian-9-drawfork-v20190426-c90e1d5-prod\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-1\"], \"os\": [\"Debian\", \"Debian-9.5\", \"Linux\"], \"pool\": [\"luci.fuchsia.prod\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4277-e1590cf\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1556674135782655",
"status": "COMPLETED",
"status_changed_ts": "1556681075631809",
"tags": [
"builder:clang",
"buildset:commit/git/db555ab4df0e7ba02618070cd1e80d55a9baa453",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/db555ab4df0e7ba02618070cd1e80d55a9baa453",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9080132641901052384",
"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/8914702579908508656/+/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:4489d3c83cbf3f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1556681075640172",
"url": "https://ci.chromium.org/b/8914702579908508656",
"utcnow_ts": "1556681076231573"
}
}
[03:24:36.238] Invocation finished in 1h55m44.173800439s with status SUCCEEDED