[20:37:30.804] New invocation is queued and will start shortly
[20:37:31.921] Starting the invocation (attempt 1)
[20:37:31.997] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:37:31.997] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:37:31.997] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9082506493475535264",
"parameters_json": "{\"builder_name\":\"clang\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://fuchsia.googlesource.com/third_party/llvm-project\",\"revision\":\"19d21854e92ed3acdeee17a6c2dd106f9e9dd058\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:clang",
"scheduler_invocation_id:9082506493475535264",
"scheduler_job_id:fuchsia/prod-clang",
"user_agent:luci-scheduler",
"buildset:commit/git/19d21854e92ed3acdeee17a6c2dd106f9e9dd058",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/19d21854e92ed3acdeee17a6c2dd106f9e9dd058",
"gitiles_ref:refs/heads/master"
]
}
[20:37:32.659] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "AUTO",
"created_by": "project:fuchsia",
"created_ts": "1554410252157059",
"id": "8917076431392528416",
"parameters_json": "{\"builder_name\": \"clang\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"revision\": \"19d21854e92ed3acdeee17a6c2dd106f9e9dd058\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1554410252518196",
"tags": [
"builder:clang",
"buildset:commit/git/19d21854e92ed3acdeee17a6c2dd106f9e9dd058",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/19d21854e92ed3acdeee17a6c2dd106f9e9dd058",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9082506493475535264",
"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/8917076431392528416/+/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": "1554410252518336",
"url": "https://ci.chromium.org/b/8917076431392528416",
"utcnow_ts": "1554410252648658"
}
}
[20:37:32.659] Task URL: https://ci.chromium.org/b/8917076431392528416
[20:37:32.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:2:0) after 1m0s
[20:37:36.683] Received PubSub notification, asking Buildbucket for the build status
[20:37:36.732] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:32.678] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:2:0)
[20:38:32.678] Timer tick, asking Buildbucket for the build status
[20:38:32.754] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:32.754] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:4:0) after 1m0s
[20:39:32.736] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:4:0)
[20:39:32.736] Timer tick, asking Buildbucket for the build status
[20:39:32.772] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:32.773] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:5:0) after 1m0s
[20:40:32.792] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:5:0)
[20:40:32.792] Timer tick, asking Buildbucket for the build status
[20:40:32.832] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:32.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:6:0) after 1m0s
[20:41:32.849] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:6:0)
[20:41:32.849] Timer tick, asking Buildbucket for the build status
[20:41:32.906] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:32.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:7:0) after 1m0s
[20:42:32.905] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:7:0)
[20:42:32.906] Timer tick, asking Buildbucket for the build status
[20:42:32.962] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:32.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:8:0) after 1m0s
[20:43:32.977] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:8:0)
[20:43:32.977] Timer tick, asking Buildbucket for the build status
[20:43:33.112] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:33.112] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:9:0) after 1m0s
[20:44:33.122] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:9:0)
[20:44:33.122] Timer tick, asking Buildbucket for the build status
[20:44:33.404] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:33.404] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:10:0) after 1m0s
[20:45:33.405] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:10:0)
[20:45:33.405] Timer tick, asking Buildbucket for the build status
[20:45:33.465] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:33.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:11:0) after 1m0s
[20:46:33.511] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:11:0)
[20:46:33.511] Timer tick, asking Buildbucket for the build status
[20:46:33.549] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:33.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:12:0) after 1m0s
[20:47:33.568] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:12:0)
[20:47:33.568] Timer tick, asking Buildbucket for the build status
[20:47:33.769] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:33.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:13:0) after 1m0s
[20:48:33.804] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:13:0)
[20:48:33.804] Timer tick, asking Buildbucket for the build status
[20:48:33.842] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:33.842] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:14:0) after 1m0s
[20:49:33.879] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:14:0)
[20:49:33.879] Timer tick, asking Buildbucket for the build status
[20:49:33.926] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:33.926] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:15:0) after 1m0s
[20:50:33.945] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:15:0)
[20:50:33.945] Timer tick, asking Buildbucket for the build status
[20:50:34.074] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:34.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:16:0) after 1m0s
[20:51:34.091] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:16:0)
[20:51:34.091] Timer tick, asking Buildbucket for the build status
[20:51:34.290] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:34.290] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:17:0) after 1m0s
[20:52:34.304] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:17:0)
[20:52:34.304] Timer tick, asking Buildbucket for the build status
[20:52:34.401] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:34.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:18:0) after 1m0s
[20:53:34.466] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:18:0)
[20:53:34.466] Timer tick, asking Buildbucket for the build status
[20:53:34.514] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:34.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:19:0) after 1m0s
[20:54:34.538] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:19:0)
[20:54:34.538] Timer tick, asking Buildbucket for the build status
[20:54:34.875] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:34.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:20:0) after 1m0s
[20:55:34.896] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:20:0)
[20:55:34.896] Timer tick, asking Buildbucket for the build status
[20:55:35.105] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:35.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:21:0) after 1m0s
[20:56:35.106] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:21:0)
[20:56:35.106] Timer tick, asking Buildbucket for the build status
[20:56:35.155] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:35.155] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:22:0) after 1m0s
[20:57:35.182] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:22:0)
[20:57:35.182] Timer tick, asking Buildbucket for the build status
[20:57:35.246] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:35.246] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:23:0) after 1m0s
[20:58:35.217] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:23:0)
[20:58:35.217] Timer tick, asking Buildbucket for the build status
[20:58:35.265] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:35.265] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:24:0) after 1m0s
[20:59:35.284] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:24:0)
[20:59:35.284] Timer tick, asking Buildbucket for the build status
[20:59:35.568] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:35.568] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:25:0) after 1m0s
[21:00:35.592] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:25:0)
[21:00:35.592] Timer tick, asking Buildbucket for the build status
[21:00:35.637] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:35.637] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:26:0) after 1m0s
[21:01:35.668] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:26:0)
[21:01:35.668] Timer tick, asking Buildbucket for the build status
[21:01:36.096] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:36.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:27:0) after 1m0s
[21:02:36.148] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:27:0)
[21:02:36.148] Timer tick, asking Buildbucket for the build status
[21:02:36.202] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:36.202] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:28:0) after 1m0s
[21:03:36.207] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:28:0)
[21:03:36.207] Timer tick, asking Buildbucket for the build status
[21:03:36.272] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:36.272] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:29:0) after 1m0s
[21:04:36.246] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:29:0)
[21:04:36.246] Timer tick, asking Buildbucket for the build status
[21:04:36.586] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:36.586] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:30:0) after 1m0s
[21:05:36.586] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:30:0)
[21:05:36.586] Timer tick, asking Buildbucket for the build status
[21:05:36.628] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:36.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:31:0) after 1m0s
[21:06:36.676] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:31:0)
[21:06:36.676] Timer tick, asking Buildbucket for the build status
[21:06:36.811] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:36.811] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:32:0) after 1m0s
[21:07:36.805] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:32:0)
[21:07:36.805] Timer tick, asking Buildbucket for the build status
[21:07:36.958] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:36.958] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:33:0) after 1m0s
[21:08:36.979] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:33:0)
[21:08:36.979] Timer tick, asking Buildbucket for the build status
[21:08:37.086] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:37.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:34:0) after 1m0s
[21:09:37.075] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:34:0)
[21:09:37.075] Timer tick, asking Buildbucket for the build status
[21:09:37.261] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:37.261] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:35:0) after 1m0s
[21:10:37.296] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:35:0)
[21:10:37.296] Timer tick, asking Buildbucket for the build status
[21:10:39.315] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:39.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:36:0) after 1m0s
[21:11:39.326] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:36:0)
[21:11:39.326] Timer tick, asking Buildbucket for the build status
[21:11:39.383] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:39.383] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:37:0) after 1m0s
[21:12:39.405] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:37:0)
[21:12:39.405] Timer tick, asking Buildbucket for the build status
[21:12:39.560] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:39.560] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:38:0) after 1m0s
[21:13:39.579] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:38:0)
[21:13:39.579] Timer tick, asking Buildbucket for the build status
[21:13:39.637] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:39.637] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:39:0) after 1m0s
[21:14:39.634] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:39:0)
[21:14:39.634] Timer tick, asking Buildbucket for the build status
[21:14:39.875] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:39.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:40:0) after 1m0s
[21:15:39.886] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:40:0)
[21:15:39.886] Timer tick, asking Buildbucket for the build status
[21:15:39.931] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:39.931] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:41:0) after 1m0s
[21:16:39.903] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:41:0)
[21:16:39.903] Timer tick, asking Buildbucket for the build status
[21:16:39.978] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:39.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:42:0) after 1m0s
[21:17:40.025] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:42:0)
[21:17:40.025] Timer tick, asking Buildbucket for the build status
[21:17:40.172] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:40.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:43:0) after 1m0s
[21:18:40.186] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:43:0)
[21:18:40.186] Timer tick, asking Buildbucket for the build status
[21:18:40.276] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:40.276] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:44:0) after 1m0s
[21:19:40.292] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:44:0)
[21:19:40.292] Timer tick, asking Buildbucket for the build status
[21:19:40.339] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:40.339] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:45:0) after 1m0s
[21:20:40.411] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:45:0)
[21:20:40.411] Timer tick, asking Buildbucket for the build status
[21:20:40.457] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:40.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:46:0) after 1m0s
[21:21:40.498] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:46:0)
[21:21:40.498] Timer tick, asking Buildbucket for the build status
[21:21:40.604] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:40.604] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:47:0) after 1m0s
[21:22:40.627] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:47:0)
[21:22:40.627] Timer tick, asking Buildbucket for the build status
[21:22:40.781] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:40.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:48:0) after 1m0s
[21:23:40.843] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:48:0)
[21:23:40.843] Timer tick, asking Buildbucket for the build status
[21:23:40.950] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:40.950] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:49:0) after 1m0s
[21:24:40.976] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:49:0)
[21:24:40.976] Timer tick, asking Buildbucket for the build status
[21:24:41.085] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:41.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:50:0) after 1m0s
[21:25:41.099] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:50:0)
[21:25:41.099] Timer tick, asking Buildbucket for the build status
[21:25:41.477] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:41.477] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:51:0) after 1m0s
[21:26:41.510] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:51:0)
[21:26:41.510] Timer tick, asking Buildbucket for the build status
[21:26:41.895] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:41.895] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:52:0) after 1m0s
[21:27:41.909] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:52:0)
[21:27:41.909] Timer tick, asking Buildbucket for the build status
[21:27:42.062] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:42.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:53:0) after 1m0s
[21:28:42.274] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:53:0)
[21:28:42.274] Timer tick, asking Buildbucket for the build status
[21:28:42.349] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:42.349] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:54:0) after 1m0s
[21:29:42.370] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:54:0)
[21:29:42.370] Timer tick, asking Buildbucket for the build status
[21:29:42.484] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:42.484] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:55:0) after 1m0s
[21:30:42.508] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:55:0)
[21:30:42.508] Timer tick, asking Buildbucket for the build status
[21:30:42.599] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:42.599] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:56:0) after 1m0s
[21:31:42.657] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:56:0)
[21:31:42.657] Timer tick, asking Buildbucket for the build status
[21:31:42.720] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:42.720] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:57:0) after 1m0s
[21:32:42.742] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:57:0)
[21:32:42.742] Timer tick, asking Buildbucket for the build status
[21:32:42.783] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:42.783] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:58:0) after 1m0s
[21:33:42.807] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:58:0)
[21:33:42.807] Timer tick, asking Buildbucket for the build status
[21:33:42.880] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:42.880] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:59:0) after 1m0s
[21:34:42.899] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:59:0)
[21:34:42.899] Timer tick, asking Buildbucket for the build status
[21:34:43.074] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:43.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:60:0) after 1m0s
[21:35:43.096] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:60:0)
[21:35:43.096] Timer tick, asking Buildbucket for the build status
[21:35:43.135] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:43.135] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:61:0) after 1m0s
[21:36:43.111] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:61:0)
[21:36:43.111] Timer tick, asking Buildbucket for the build status
[21:36:43.261] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:43.261] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:62:0) after 1m0s
[21:37:43.273] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:62:0)
[21:37:43.273] Timer tick, asking Buildbucket for the build status
[21:37:43.384] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:43.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:63:0) after 1m0s
[21:38:43.389] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:63:0)
[21:38:43.389] Timer tick, asking Buildbucket for the build status
[21:38:43.977] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:43.977] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:64:0) after 1m0s
[21:39:44.065] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:64:0)
[21:39:44.065] Timer tick, asking Buildbucket for the build status
[21:39:44.162] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:44.162] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:65:0) after 1m0s
[21:40:44.180] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:65:0)
[21:40:44.180] Timer tick, asking Buildbucket for the build status
[21:40:44.222] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:44.222] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:66:0) after 1m0s
[21:41:44.250] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:66:0)
[21:41:44.250] Timer tick, asking Buildbucket for the build status
[21:41:44.375] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:44.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:67:0) after 1m0s
[21:42:44.390] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:67:0)
[21:42:44.390] Timer tick, asking Buildbucket for the build status
[21:42:44.429] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:44.429] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:68:0) after 1m0s
[21:43:44.418] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:68:0)
[21:43:44.418] Timer tick, asking Buildbucket for the build status
[21:43:44.478] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:44.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:69:0) after 1m0s
[21:44:44.502] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:69:0)
[21:44:44.502] Timer tick, asking Buildbucket for the build status
[21:44:44.543] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:44.543] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:70:0) after 1m0s
[21:45:44.571] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:70:0)
[21:45:44.571] Timer tick, asking Buildbucket for the build status
[21:45:44.616] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:44.617] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:71:0) after 1m0s
[21:46:44.622] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:71:0)
[21:46:44.622] Timer tick, asking Buildbucket for the build status
[21:46:44.868] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:44.868] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:72:0) after 1m0s
[21:47:44.853] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:72:0)
[21:47:44.853] Timer tick, asking Buildbucket for the build status
[21:47:44.978] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:44.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:73:0) after 1m0s
[21:48:44.968] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:73:0)
[21:48:44.968] Timer tick, asking Buildbucket for the build status
[21:48:45.099] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:45.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:74:0) after 1m0s
[21:49:45.074] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:74:0)
[21:49:45.074] Timer tick, asking Buildbucket for the build status
[21:49:45.197] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:45.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:75:0) after 1m0s
[21:50:45.172] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:75:0)
[21:50:45.172] Timer tick, asking Buildbucket for the build status
[21:50:45.254] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:45.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:76:0) after 1m0s
[21:51:45.250] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:76:0)
[21:51:45.250] Timer tick, asking Buildbucket for the build status
[21:51:45.297] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:45.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:77:0) after 1m0s
[21:52:45.271] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:77:0)
[21:52:45.271] Timer tick, asking Buildbucket for the build status
[21:52:45.335] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:45.335] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:78:0) after 1m0s
[21:53:45.336] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:78:0)
[21:53:45.336] Timer tick, asking Buildbucket for the build status
[21:53:45.479] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:45.479] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:79:0) after 1m0s
[21:54:45.468] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:79:0)
[21:54:45.468] Timer tick, asking Buildbucket for the build status
[21:54:45.675] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:45.675] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:80:0) after 1m0s
[21:55:45.698] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:80:0)
[21:55:45.698] Timer tick, asking Buildbucket for the build status
[21:55:45.960] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:45.960] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:81:0) after 1m0s
[21:56:45.973] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:81:0)
[21:56:45.973] Timer tick, asking Buildbucket for the build status
[21:56:46.092] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:46.092] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:82:0) after 1m0s
[21:57:46.087] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:82:0)
[21:57:46.087] Timer tick, asking Buildbucket for the build status
[21:57:46.275] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:46.275] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:83:0) after 1m0s
[21:58:46.294] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:83:0)
[21:58:46.294] Timer tick, asking Buildbucket for the build status
[21:58:46.809] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:46.809] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:84:0) after 1m0s
[21:59:46.832] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:84:0)
[21:59:46.832] Timer tick, asking Buildbucket for the build status
[21:59:46.880] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:46.880] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:85:0) after 1m0s
[22:00:46.901] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:85:0)
[22:00:46.901] Timer tick, asking Buildbucket for the build status
[22:00:47.269] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:47.269] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:86:0) after 1m0s
[22:01:47.295] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:86:0)
[22:01:47.295] Timer tick, asking Buildbucket for the build status
[22:01:47.337] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:47.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:87:0) after 1m0s
[22:02:47.321] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:87:0)
[22:02:47.321] Timer tick, asking Buildbucket for the build status
[22:02:47.390] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:47.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:88:0) after 1m0s
[22:03:47.425] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:88:0)
[22:03:47.425] Timer tick, asking Buildbucket for the build status
[22:03:47.611] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:47.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:89:0) after 1m0s
[22:04:47.595] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:89:0)
[22:04:47.595] Timer tick, asking Buildbucket for the build status
[22:04:47.805] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:47.805] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:90:0) after 1m0s
[22:05:47.825] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:90:0)
[22:05:47.825] Timer tick, asking Buildbucket for the build status
[22:05:47.910] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:47.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:91:0) after 1m0s
[22:06:47.940] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:91:0)
[22:06:47.940] Timer tick, asking Buildbucket for the build status
[22:06:48.117] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:48.117] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:92:0) after 1m0s
[22:07:48.131] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:92:0)
[22:07:48.131] Timer tick, asking Buildbucket for the build status
[22:07:48.214] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:48.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:93:0) after 1m0s
[22:08:48.234] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:93:0)
[22:08:48.234] Timer tick, asking Buildbucket for the build status
[22:08:48.334] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:48.334] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:94:0) after 1m0s
[22:09:48.362] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:94:0)
[22:09:48.362] Timer tick, asking Buildbucket for the build status
[22:09:48.444] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:48.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:95:0) after 1m0s
[22:10:48.427] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:95:0)
[22:10:48.427] Timer tick, asking Buildbucket for the build status
[22:10:48.479] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:48.479] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:96:0) after 1m0s
[22:11:48.499] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:96:0)
[22:11:48.499] Timer tick, asking Buildbucket for the build status
[22:11:48.538] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:48.538] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:97:0) after 1m0s
[22:12:48.561] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:97:0)
[22:12:48.561] Timer tick, asking Buildbucket for the build status
[22:12:48.685] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:48.685] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:98:0) after 1m0s
[22:13:48.683] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:98:0)
[22:13:48.683] Timer tick, asking Buildbucket for the build status
[22:13:48.729] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:48.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:99:0) after 1m0s
[22:14:48.753] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:99:0)
[22:14:48.753] Timer tick, asking Buildbucket for the build status
[22:14:48.827] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:48.827] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:100:0) after 1m0s
[22:15:48.850] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:100:0)
[22:15:48.850] Timer tick, asking Buildbucket for the build status
[22:15:49.378] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:49.378] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:101:0) after 1m0s
[22:16:49.377] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:101:0)
[22:16:49.377] Timer tick, asking Buildbucket for the build status
[22:16:49.450] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:49.450] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:102:0) after 1m0s
[22:17:49.471] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:102:0)
[22:17:49.471] Timer tick, asking Buildbucket for the build status
[22:17:49.594] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:49.594] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:103:0) after 1m0s
[22:18:49.600] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:103:0)
[22:18:49.600] Timer tick, asking Buildbucket for the build status
[22:18:49.649] Build 8917076431392528416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:49.649] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9082506493475535264:104:0) after 1m0s
[22:19:08.195] Received PubSub notification, asking Buildbucket for the build status
[22:19:08.242] Build 8917076431392528416: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:19:08.242] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "AUTO",
"completed_ts": "1554416347352873",
"created_by": "project:fuchsia",
"created_ts": "1554410252157059",
"id": "8917076431392528416",
"parameters_json": "{\"builder_name\": \"clang\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"revision\": \"19d21854e92ed3acdeee17a6c2dd106f9e9dd058\"}}",
"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-ffce87c5-us-central1-b-djs9\", \"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\": \"19d21854e92ed3acdeee17a6c2dd106f9e9dd058\", \"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-ffce87c5-us-central1-b-djs9\"], \"image\": [\"fuchsia-debian-9-drawfork-v20190319-3f58170\"], \"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\": [\"4243-f38882f\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1554410256236095",
"status": "COMPLETED",
"status_changed_ts": "1554416347826763",
"tags": [
"builder:clang",
"buildset:commit/git/19d21854e92ed3acdeee17a6c2dd106f9e9dd058",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/19d21854e92ed3acdeee17a6c2dd106f9e9dd058",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9082506493475535264",
"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/8917076431392528416/+/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:4402e3b51911a010",
"user_agent:luci-scheduler"
],
"updated_ts": "1554416347830901",
"url": "https://ci.chromium.org/b/8917076431392528416",
"utcnow_ts": "1554416348233519"
}
}
[22:19:08.242] Invocation finished in 1h41m37.454796215s with status SUCCEEDED