[20:43:22.861] New invocation is queued and will start shortly
[20:43:23.983] Starting the invocation (attempt 1)
[20:43:24.016] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:43:24.016] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:43:24.017] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9085042839376420112",
"parameters_json": "{\"builder_name\":\"clang\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://fuchsia.googlesource.com/third_party/llvm-project\",\"revision\":\"9d782f998da5030a29207f5b6e42d0839c4d9954\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:clang",
"scheduler_invocation_id:9085042839376420112",
"scheduler_job_id:fuchsia/prod-clang",
"user_agent:luci-scheduler",
"buildset:commit/git/9d782f998da5030a29207f5b6e42d0839c4d9954",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/9d782f998da5030a29207f5b6e42d0839c4d9954",
"gitiles_ref:refs/heads/master"
]
}
[20:43:25.589] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary": true,
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551991404365609",
"id": "8919612777134993008",
"lease_expiration_ts": "1552117405114924",
"lease_key": "1590034833",
"parameters_json": "{\"builder_name\": \"clang\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"revision\": \"9d782f998da5030a29207f5b6e42d0839c4d9954\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1551991405231757",
"tags": [
"builder:clang",
"buildset:commit/git/9d782f998da5030a29207f5b6e42d0839c4d9954",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/9d782f998da5030a29207f5b6e42d0839c4d9954",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085042839376420112",
"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/8919612777134993008/+/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:4372b70110500610",
"user_agent:luci-scheduler"
],
"updated_ts": "1551991405231857",
"url": "https://ci.chromium.org/b/8919612777134993008",
"utcnow_ts": "1551991405511326"
}
}
[20:43:25.589] Task URL: https://ci.chromium.org/b/8919612777134993008
[20:43:25.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:2:0) after 1m0s
[20:43:42.510] Received PubSub notification, asking Buildbucket for the build status
[20:43:42.658] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:25.614] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:2:0)
[20:44:25.614] Timer tick, asking Buildbucket for the build status
[20:44:25.680] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:25.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:4:0) after 1m0s
[20:45:25.699] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:4:0)
[20:45:25.699] Timer tick, asking Buildbucket for the build status
[20:45:25.852] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:25.852] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:5:0) after 1m0s
[20:46:25.847] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:5:0)
[20:46:25.847] Timer tick, asking Buildbucket for the build status
[20:46:25.902] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:25.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:6:0) after 1m0s
[20:47:25.899] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:6:0)
[20:47:25.899] Timer tick, asking Buildbucket for the build status
[20:47:26.085] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:26.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:7:0) after 1m0s
[20:48:26.088] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:7:0)
[20:48:26.088] Timer tick, asking Buildbucket for the build status
[20:48:26.145] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:26.145] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:8:0) after 1m0s
[20:49:26.213] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:8:0)
[20:49:26.213] Timer tick, asking Buildbucket for the build status
[20:49:26.264] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:26.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:9:0) after 1m0s
[20:50:26.289] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:9:0)
[20:50:26.289] Timer tick, asking Buildbucket for the build status
[20:50:26.333] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:26.333] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:10:0) after 1m0s
[20:51:26.349] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:10:0)
[20:51:26.349] Timer tick, asking Buildbucket for the build status
[20:51:26.403] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:26.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:11:0) after 1m0s
[20:52:26.376] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:11:0)
[20:52:26.376] Timer tick, asking Buildbucket for the build status
[20:52:26.447] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:26.447] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:12:0) after 1m0s
[20:53:26.426] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:12:0)
[20:53:26.426] Timer tick, asking Buildbucket for the build status
[20:53:26.569] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:26.569] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:13:0) after 1m0s
[20:54:26.591] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:13:0)
[20:54:26.591] Timer tick, asking Buildbucket for the build status
[20:54:26.680] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:26.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:14:0) after 1m0s
[20:55:26.660] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:14:0)
[20:55:26.660] Timer tick, asking Buildbucket for the build status
[20:55:26.781] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:26.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:15:0) after 1m0s
[20:56:26.764] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:15:0)
[20:56:26.764] Timer tick, asking Buildbucket for the build status
[20:56:26.809] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:26.809] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:16:0) after 1m0s
[20:57:26.848] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:16:0)
[20:57:26.848] Timer tick, asking Buildbucket for the build status
[20:57:26.908] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:26.908] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:17:0) after 1m0s
[20:58:26.910] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:17:0)
[20:58:26.910] Timer tick, asking Buildbucket for the build status
[20:58:26.952] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:26.952] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:18:0) after 1m0s
[20:59:26.969] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:18:0)
[20:59:26.969] Timer tick, asking Buildbucket for the build status
[20:59:27.032] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:27.032] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:19:0) after 1m0s
[21:00:27.065] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:19:0)
[21:00:27.065] Timer tick, asking Buildbucket for the build status
[21:00:27.182] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:27.182] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:20:0) after 1m0s
[21:01:27.207] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:20:0)
[21:01:27.207] Timer tick, asking Buildbucket for the build status
[21:01:27.268] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:27.268] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:21:0) after 1m0s
[21:02:27.291] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:21:0)
[21:02:27.291] Timer tick, asking Buildbucket for the build status
[21:02:27.569] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:27.569] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:22:0) after 1m0s
[21:03:27.588] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:22:0)
[21:03:27.588] Timer tick, asking Buildbucket for the build status
[21:03:27.720] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:27.720] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:23:0) after 1m0s
[21:04:27.705] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:23:0)
[21:04:27.705] Timer tick, asking Buildbucket for the build status
[21:04:27.785] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:27.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:24:0) after 1m0s
[21:05:27.797] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:24:0)
[21:05:27.797] Timer tick, asking Buildbucket for the build status
[21:05:27.840] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:27.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:25:0) after 1m0s
[21:06:27.816] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:25:0)
[21:06:27.816] Timer tick, asking Buildbucket for the build status
[21:06:27.866] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:27.866] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:26:0) after 1m0s
[21:07:27.889] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:26:0)
[21:07:27.889] Timer tick, asking Buildbucket for the build status
[21:07:27.941] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:27.941] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:27:0) after 1m0s
[21:08:27.973] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:27:0)
[21:08:27.973] Timer tick, asking Buildbucket for the build status
[21:08:28.048] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:28.048] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:28:0) after 1m0s
[21:09:28.024] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:28:0)
[21:09:28.024] Timer tick, asking Buildbucket for the build status
[21:09:28.150] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:28.150] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:29:0) after 1m0s
[21:10:28.171] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:29:0)
[21:10:28.171] Timer tick, asking Buildbucket for the build status
[21:10:28.378] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:28.378] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:30:0) after 1m0s
[21:11:28.401] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:30:0)
[21:11:28.401] Timer tick, asking Buildbucket for the build status
[21:11:28.497] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:28.497] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:31:0) after 1m0s
[21:12:28.488] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:31:0)
[21:12:28.488] Timer tick, asking Buildbucket for the build status
[21:12:28.529] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:28.529] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:32:0) after 1m0s
[21:13:28.560] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:32:0)
[21:13:28.560] Timer tick, asking Buildbucket for the build status
[21:13:28.692] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:28.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:33:0) after 1m0s
[21:14:28.713] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:33:0)
[21:14:28.713] Timer tick, asking Buildbucket for the build status
[21:14:28.815] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:28.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:34:0) after 1m0s
[21:15:28.962] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:34:0)
[21:15:28.962] Timer tick, asking Buildbucket for the build status
[21:15:29.035] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:29.035] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:35:0) after 1m0s
[21:16:29.069] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:35:0)
[21:16:29.069] Timer tick, asking Buildbucket for the build status
[21:16:29.133] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:29.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:36:0) after 1m0s
[21:17:29.201] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:36:0)
[21:17:29.201] Timer tick, asking Buildbucket for the build status
[21:17:29.298] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:29.298] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:37:0) after 1m0s
[21:18:29.301] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:37:0)
[21:18:29.301] Timer tick, asking Buildbucket for the build status
[21:18:29.350] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:29.350] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:38:0) after 1m0s
[21:19:29.368] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:38:0)
[21:19:29.368] Timer tick, asking Buildbucket for the build status
[21:19:29.492] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:29.492] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:39:0) after 1m0s
[21:20:29.674] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:39:0)
[21:20:29.674] Timer tick, asking Buildbucket for the build status
[21:20:29.790] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:29.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:40:0) after 1m0s
[21:21:29.814] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:40:0)
[21:21:29.814] Timer tick, asking Buildbucket for the build status
[21:21:29.858] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:29.858] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:41:0) after 1m0s
[21:22:29.874] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:41:0)
[21:22:29.874] Timer tick, asking Buildbucket for the build status
[21:22:29.920] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:29.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:42:0) after 1m0s
[21:23:29.938] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:42:0)
[21:23:29.938] Timer tick, asking Buildbucket for the build status
[21:23:29.993] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:29.993] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:43:0) after 1m0s
[21:24:30.000] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:43:0)
[21:24:30.000] Timer tick, asking Buildbucket for the build status
[21:24:30.099] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:30.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:44:0) after 1m0s
[21:25:30.144] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:44:0)
[21:25:30.144] Timer tick, asking Buildbucket for the build status
[21:25:30.220] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:30.220] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:45:0) after 1m0s
[21:26:30.242] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:45:0)
[21:26:30.242] Timer tick, asking Buildbucket for the build status
[21:26:30.283] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:30.283] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:46:0) after 1m0s
[21:27:30.301] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:46:0)
[21:27:30.301] Timer tick, asking Buildbucket for the build status
[21:27:30.358] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:30.358] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:47:0) after 1m0s
[21:28:30.340] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:47:0)
[21:28:30.340] Timer tick, asking Buildbucket for the build status
[21:28:30.430] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:30.430] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:48:0) after 1m0s
[21:29:30.450] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:48:0)
[21:29:30.450] Timer tick, asking Buildbucket for the build status
[21:29:30.681] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:30.681] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:49:0) after 1m0s
[21:30:30.682] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:49:0)
[21:30:30.682] Timer tick, asking Buildbucket for the build status
[21:30:30.802] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:30.802] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:50:0) after 1m0s
[21:31:30.784] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:50:0)
[21:31:30.784] Timer tick, asking Buildbucket for the build status
[21:31:30.852] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:30.852] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:51:0) after 1m0s
[21:32:30.885] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:51:0)
[21:32:30.885] Timer tick, asking Buildbucket for the build status
[21:32:31.079] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:31.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:52:0) after 1m0s
[21:33:31.085] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:52:0)
[21:33:31.085] Timer tick, asking Buildbucket for the build status
[21:33:31.172] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:31.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:53:0) after 1m0s
[21:34:31.164] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:53:0)
[21:34:31.164] Timer tick, asking Buildbucket for the build status
[21:34:31.278] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:31.278] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:54:0) after 1m0s
[21:35:31.298] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:54:0)
[21:35:31.298] Timer tick, asking Buildbucket for the build status
[21:35:31.341] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:31.341] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:55:0) after 1m0s
[21:36:31.383] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:55:0)
[21:36:31.383] Timer tick, asking Buildbucket for the build status
[21:36:31.434] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:31.434] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:56:0) after 1m0s
[21:37:31.471] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:56:0)
[21:37:31.471] Timer tick, asking Buildbucket for the build status
[21:37:31.535] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:31.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:57:0) after 1m0s
[21:38:31.547] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:57:0)
[21:38:31.547] Timer tick, asking Buildbucket for the build status
[21:38:31.614] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:31.614] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:58:0) after 1m0s
[21:39:31.626] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:58:0)
[21:39:31.626] Timer tick, asking Buildbucket for the build status
[21:39:31.946] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:31.946] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:59:0) after 1m0s
[21:40:31.930] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:59:0)
[21:40:31.930] Timer tick, asking Buildbucket for the build status
[21:40:32.173] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:32.173] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:60:0) after 1m0s
[21:41:32.150] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:60:0)
[21:41:32.150] Timer tick, asking Buildbucket for the build status
[21:41:32.197] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:32.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:61:0) after 1m0s
[21:42:32.219] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:61:0)
[21:42:32.219] Timer tick, asking Buildbucket for the build status
[21:42:32.468] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:32.468] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:62:0) after 1m0s
[21:43:32.494] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:62:0)
[21:43:32.494] Timer tick, asking Buildbucket for the build status
[21:43:32.664] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:32.664] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:63:0) after 1m0s
[21:44:32.688] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:63:0)
[21:44:32.688] Timer tick, asking Buildbucket for the build status
[21:44:32.821] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:32.821] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:64:0) after 1m0s
[21:45:32.816] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:64:0)
[21:45:32.816] Timer tick, asking Buildbucket for the build status
[21:45:32.862] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:32.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:65:0) after 1m0s
[21:46:32.934] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:65:0)
[21:46:32.934] Timer tick, asking Buildbucket for the build status
[21:46:33.035] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:33.035] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:66:0) after 1m0s
[21:47:33.038] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:66:0)
[21:47:33.038] Timer tick, asking Buildbucket for the build status
[21:47:33.173] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:33.173] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:67:0) after 1m0s
[21:48:33.211] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:67:0)
[21:48:33.211] Timer tick, asking Buildbucket for the build status
[21:48:33.257] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:33.257] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:68:0) after 1m0s
[21:49:33.277] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:68:0)
[21:49:33.277] Timer tick, asking Buildbucket for the build status
[21:49:33.395] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:33.395] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:69:0) after 1m0s
[21:50:33.416] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:69:0)
[21:50:33.417] Timer tick, asking Buildbucket for the build status
[21:50:33.655] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:33.655] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:70:0) after 1m0s
[21:51:33.676] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:70:0)
[21:51:33.676] Timer tick, asking Buildbucket for the build status
[21:51:33.733] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:33.733] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:71:0) after 1m0s
[21:52:33.715] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:71:0)
[21:52:33.715] Timer tick, asking Buildbucket for the build status
[21:52:33.769] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:33.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:72:0) after 1m0s
[21:53:33.819] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:72:0)
[21:53:33.819] Timer tick, asking Buildbucket for the build status
[21:53:33.864] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:33.864] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:73:0) after 1m0s
[21:54:33.862] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:73:0)
[21:54:33.862] Timer tick, asking Buildbucket for the build status
[21:54:33.930] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:33.931] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:74:0) after 1m0s
[21:55:33.953] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:74:0)
[21:55:33.953] Timer tick, asking Buildbucket for the build status
[21:55:34.070] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:34.070] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:75:0) after 1m0s
[21:56:34.141] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:75:0)
[21:56:34.141] Timer tick, asking Buildbucket for the build status
[21:56:34.314] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:34.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:76:0) after 1m0s
[21:57:34.357] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:76:0)
[21:57:34.357] Timer tick, asking Buildbucket for the build status
[21:57:34.412] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:34.412] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:77:0) after 1m0s
[21:58:34.429] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:77:0)
[21:58:34.429] Timer tick, asking Buildbucket for the build status
[21:58:34.488] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:34.488] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:78:0) after 1m0s
[21:59:34.472] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:78:0)
[21:59:34.472] Timer tick, asking Buildbucket for the build status
[21:59:34.668] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:34.668] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:79:0) after 1m0s
[22:00:34.648] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:79:0)
[22:00:34.648] Timer tick, asking Buildbucket for the build status
[22:00:34.726] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:34.726] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:80:0) after 1m0s
[22:01:34.770] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:80:0)
[22:01:34.770] Timer tick, asking Buildbucket for the build status
[22:01:34.891] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:34.891] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:81:0) after 1m0s
[22:02:34.896] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:81:0)
[22:02:34.896] Timer tick, asking Buildbucket for the build status
[22:02:35.058] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:35.058] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:82:0) after 1m0s
[22:03:35.054] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:82:0)
[22:03:35.054] Timer tick, asking Buildbucket for the build status
[22:03:35.193] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:35.193] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:83:0) after 1m0s
[22:04:35.226] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:83:0)
[22:04:35.226] Timer tick, asking Buildbucket for the build status
[22:04:35.282] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:35.282] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:84:0) after 1m0s
[22:05:35.319] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:84:0)
[22:05:35.319] Timer tick, asking Buildbucket for the build status
[22:05:35.366] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:35.366] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:85:0) after 1m0s
[22:06:35.360] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:85:0)
[22:06:35.360] Timer tick, asking Buildbucket for the build status
[22:06:35.425] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:35.425] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:86:0) after 1m0s
[22:07:35.447] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:86:0)
[22:07:35.447] Timer tick, asking Buildbucket for the build status
[22:07:35.781] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:35.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:87:0) after 1m0s
[22:08:35.821] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:87:0)
[22:08:35.821] Timer tick, asking Buildbucket for the build status
[22:08:35.875] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:35.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:88:0) after 1m0s
[22:09:35.915] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:88:0)
[22:09:35.915] Timer tick, asking Buildbucket for the build status
[22:09:35.969] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:35.969] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:89:0) after 1m0s
[22:10:35.988] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:89:0)
[22:10:35.988] Timer tick, asking Buildbucket for the build status
[22:10:36.074] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:36.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:90:0) after 1m0s
[22:11:36.051] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:90:0)
[22:11:36.051] Timer tick, asking Buildbucket for the build status
[22:11:36.112] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:36.112] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:91:0) after 1m0s
[22:12:36.143] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:91:0)
[22:12:36.143] Timer tick, asking Buildbucket for the build status
[22:12:36.203] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:36.203] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:92:0) after 1m0s
[22:13:36.224] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:92:0)
[22:13:36.224] Timer tick, asking Buildbucket for the build status
[22:13:36.265] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:36.265] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:93:0) after 1m0s
[22:14:36.247] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:93:0)
[22:14:36.247] Timer tick, asking Buildbucket for the build status
[22:14:36.490] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:36.490] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:94:0) after 1m0s
[22:15:36.479] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:94:0)
[22:15:36.479] Timer tick, asking Buildbucket for the build status
[22:15:36.818] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:36.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:95:0) after 1m0s
[22:16:36.824] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:95:0)
[22:16:36.824] Timer tick, asking Buildbucket for the build status
[22:16:36.873] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:36.873] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:96:0) after 1m0s
[22:17:36.891] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:96:0)
[22:17:36.891] Timer tick, asking Buildbucket for the build status
[22:17:36.940] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:36.940] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:97:0) after 1m0s
[22:18:36.949] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:97:0)
[22:18:36.949] Timer tick, asking Buildbucket for the build status
[22:18:37.007] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:37.007] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:98:0) after 1m0s
[22:19:37.033] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:98:0)
[22:19:37.033] Timer tick, asking Buildbucket for the build status
[22:19:37.196] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:37.196] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:99:0) after 1m0s
[22:20:37.240] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:99:0)
[22:20:37.240] Timer tick, asking Buildbucket for the build status
[22:20:37.388] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:37.388] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:100:0) after 1m0s
[22:21:37.420] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:100:0)
[22:21:37.420] Timer tick, asking Buildbucket for the build status
[22:21:37.504] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:37.504] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:101:0) after 1m0s
[22:22:37.528] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:101:0)
[22:22:37.528] Timer tick, asking Buildbucket for the build status
[22:22:37.599] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:37.599] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:102:0) after 1m0s
[22:23:37.607] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:102:0)
[22:23:37.607] Timer tick, asking Buildbucket for the build status
[22:23:37.660] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:37.660] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:103:0) after 1m0s
[22:24:37.666] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:103:0)
[22:24:37.666] Timer tick, asking Buildbucket for the build status
[22:24:37.777] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:37.777] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:104:0) after 1m0s
[22:25:37.799] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:104:0)
[22:25:37.799] Timer tick, asking Buildbucket for the build status
[22:25:37.923] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:37.923] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:105:0) after 1m0s
[22:26:37.943] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:105:0)
[22:26:37.943] Timer tick, asking Buildbucket for the build status
[22:26:38.000] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:38.000] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:106:0) after 1m0s
[22:27:37.995] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:106:0)
[22:27:37.995] Timer tick, asking Buildbucket for the build status
[22:27:38.086] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:38.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:107:0) after 1m0s
[22:28:38.110] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:107:0)
[22:28:38.110] Timer tick, asking Buildbucket for the build status
[22:28:38.248] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:38.248] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:108:0) after 1m0s
[22:29:38.261] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:108:0)
[22:29:38.261] Timer tick, asking Buildbucket for the build status
[22:29:38.354] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:38.354] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:109:0) after 1m0s
[22:30:38.354] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:109:0)
[22:30:38.354] Timer tick, asking Buildbucket for the build status
[22:30:38.665] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:38.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:110:0) after 1m0s
[22:31:38.687] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:110:0)
[22:31:38.687] Timer tick, asking Buildbucket for the build status
[22:31:38.735] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:38.735] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:111:0) after 1m0s
[22:32:38.757] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:111:0)
[22:32:38.757] Timer tick, asking Buildbucket for the build status
[22:32:38.886] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:38.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:112:0) after 1m0s
[22:33:38.886] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:112:0)
[22:33:38.886] Timer tick, asking Buildbucket for the build status
[22:33:38.962] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:38.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:113:0) after 1m0s
[22:34:38.958] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:113:0)
[22:34:38.958] Timer tick, asking Buildbucket for the build status
[22:34:39.006] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:39.006] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:114:0) after 1m0s
[22:35:39.035] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:114:0)
[22:35:39.035] Timer tick, asking Buildbucket for the build status
[22:35:39.117] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:39.117] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:115:0) after 1m0s
[22:36:39.137] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:115:0)
[22:36:39.137] Timer tick, asking Buildbucket for the build status
[22:36:39.185] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:39.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:116:0) after 1m0s
[22:37:39.186] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:116:0)
[22:37:39.186] Timer tick, asking Buildbucket for the build status
[22:37:39.301] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:39.301] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:117:0) after 1m0s
[22:38:39.307] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:117:0)
[22:38:39.307] Timer tick, asking Buildbucket for the build status
[22:38:39.387] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:39.387] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:118:0) after 1m0s
[22:39:39.460] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:118:0)
[22:39:39.460] Timer tick, asking Buildbucket for the build status
[22:39:39.524] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:39.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:119:0) after 1m0s
[22:40:39.546] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:119:0)
[22:40:39.546] Timer tick, asking Buildbucket for the build status
[22:40:39.677] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:39.677] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:120:0) after 1m0s
[22:41:39.711] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:120:0)
[22:41:39.711] Timer tick, asking Buildbucket for the build status
[22:41:39.756] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:39.756] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:121:0) after 1m0s
[22:42:39.776] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:121:0)
[22:42:39.776] Timer tick, asking Buildbucket for the build status
[22:42:39.818] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:39.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:122:0) after 1m0s
[22:43:39.823] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:122:0)
[22:43:39.823] Timer tick, asking Buildbucket for the build status
[22:43:39.872] Build 8919612777134993008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:39.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang:9085042839376420112:123:0) after 1m0s
[22:44:19.841] Received PubSub notification, asking Buildbucket for the build status
[22:44:19.901] Build 8919612777134993008: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[22:44:19.901] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1551998658679350",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551991404365609",
"failure_reason": "BUILD_FAILURE",
"id": "8919612777134993008",
"parameters_json": "{\"builder_name\": \"clang\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"revision\": \"9d782f998da5030a29207f5b6e42d0839c4d9954\"}}",
"project": "fuchsia",
"result": "FAILURE",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"inside_docker\": [\"0\"], \"locale\": [\"en_US.UTF-8\"], \"image\": [\"fuchsia-debian-9-drawfork-v20181107-ee01d6c\"], \"kvm\": [\"1\"], \"cpu\": [\"x64\", \"x86\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4157-fb06213\"], \"machine_type\": [\"n1-standard-1\"], \"gpu\": [\"none\"], \"cores\": [\"1\"], \"os\": [\"Debian\", \"Debian-9.5\", \"Linux\"], \"id\": [\"fuchsia-debian-1-03c1d9de-us-central1-b-dpz6\"], \"pool\": [\"luci.fuchsia.prod\"]}}, \"ui\": {\"info\": \"Failure buildbucket.run\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"branch\": \"refs/heads/master\", \"repository\": \"https://fuchsia.googlesource.com/third_party/llvm-project\", \"buildername\": \"clang\", \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"recipe\": \"buildbucket_trigger\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"timeout\": 7200.0, \"path_config\": \"generic\", \"revision\": \"9d782f998da5030a29207f5b6e42d0839c4d9954\", \"builders\": [\"clang-linux-arm64\", \"clang-linux-x64\", \"clang-mac-x64\"], \"bot_id\": \"fuchsia-debian-1-03c1d9de-us-central1-b-dpz6\"}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1551991421966614",
"status": "COMPLETED",
"status_changed_ts": "1551998659460915",
"tags": [
"builder:clang",
"buildset:commit/git/9d782f998da5030a29207f5b6e42d0839c4d9954",
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/llvm-project/+/9d782f998da5030a29207f5b6e42d0839c4d9954",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085042839376420112",
"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/8919612777134993008/+/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:4372b70110500610",
"user_agent:luci-scheduler"
],
"updated_ts": "1551998659461914",
"url": "https://ci.chromium.org/b/8919612777134993008",
"utcnow_ts": "1551998659882040"
}
}
[22:44:19.901] Invocation finished in 2h0m57.057500394s with status FAILED