[08:43:06.195] New invocation is queued and will start shortly
[08:43:06.195] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:43:07.345] Starting the invocation (attempt 1)
[08:43:07.388] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:43:07.389] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:43:07.389] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9018771175929104336",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"91.0.4440.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"9bc026ac-9d38-46e6-878c-344ea6f97c37\",\"title\":\"publish_tarball/0\"}]},\"version\":\"91.0.4440.0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9018771175929104336",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[08:43:07.956] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:infra",
"created_ts": "1615192987467599",
"id": "8853341113932058144",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"91.0.4440.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9bc026ac-9d38-46e6-878c-344ea6f97c37\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"91.0.4440.0\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615192987767155",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9018771175929104336",
"scheduler_job_id:infra/Build From Tarball",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8853341113932058144/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:recipe_name:build_from_tarball",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_task_id:",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1615192987767265",
"url": "https://ci.chromium.org/b/8853341113932058144",
"utcnow_ts": "1615192987950608"
}
}
[08:43:07.957] Task URL: https://ci.chromium.org/b/8853341113932058144
[08:43:07.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:2:0) after 1m0s
[08:44:02.951] Received PubSub notification, asking Buildbucket for the build status
[08:44:03.034] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:08.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:2:0)
[08:44:08.293] Timer tick, asking Buildbucket for the build status
[08:44:08.435] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:08.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:4:0) after 1m0s
[08:45:08.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:4:0)
[08:45:08.469] Timer tick, asking Buildbucket for the build status
[08:45:08.729] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:08.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:5:0) after 1m0s
[08:46:08.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:5:0)
[08:46:08.835] Timer tick, asking Buildbucket for the build status
[08:46:10.753] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:10.753] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:6:0) after 1m0s
[08:47:10.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:6:0)
[08:47:10.735] Timer tick, asking Buildbucket for the build status
[08:47:11.416] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:11.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:7:0) after 1m0s
[08:48:11.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:7:0)
[08:48:11.431] Timer tick, asking Buildbucket for the build status
[08:48:11.567] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:11.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:8:0) after 1m0s
[08:49:11.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:8:0)
[08:49:11.621] Timer tick, asking Buildbucket for the build status
[08:49:11.735] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:11.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:9:0) after 1m0s
[08:50:11.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:9:0)
[08:50:11.742] Timer tick, asking Buildbucket for the build status
[08:50:12.334] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:12.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:10:0) after 1m0s
[08:51:12.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:10:0)
[08:51:12.349] Timer tick, asking Buildbucket for the build status
[08:51:12.427] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:12.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:11:0) after 1m0s
[08:52:12.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:11:0)
[08:52:12.471] Timer tick, asking Buildbucket for the build status
[08:52:12.545] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:12.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:12:0) after 1m0s
[08:53:12.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:12:0)
[08:53:12.689] Timer tick, asking Buildbucket for the build status
[08:53:12.766] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:12.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:13:0) after 1m0s
[08:54:12.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:13:0)
[08:54:12.868] Timer tick, asking Buildbucket for the build status
[08:54:13.003] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:13.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:14:0) after 1m0s
[08:55:13.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:14:0)
[08:55:13.032] Timer tick, asking Buildbucket for the build status
[08:55:13.132] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:13.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:15:0) after 1m0s
[08:56:13.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:15:0)
[08:56:13.225] Timer tick, asking Buildbucket for the build status
[08:56:13.482] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:13.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:16:0) after 1m0s
[08:57:13.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:16:0)
[08:57:13.603] Timer tick, asking Buildbucket for the build status
[08:57:13.694] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:13.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:17:0) after 1m0s
[08:58:13.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:17:0)
[08:58:13.757] Timer tick, asking Buildbucket for the build status
[08:58:14.088] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:14.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:18:0) after 1m0s
[08:59:14.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:18:0)
[08:59:14.105] Timer tick, asking Buildbucket for the build status
[08:59:14.179] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:14.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:19:0) after 1m0s
[09:00:14.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:19:0)
[09:00:14.283] Timer tick, asking Buildbucket for the build status
[09:00:14.395] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:14.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:20:0) after 1m0s
[09:01:14.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:20:0)
[09:01:14.563] Timer tick, asking Buildbucket for the build status
[09:01:14.656] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:14.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:21:0) after 1m0s
[09:02:14.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:21:0)
[09:02:14.639] Timer tick, asking Buildbucket for the build status
[09:02:14.711] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:14.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:22:0) after 1m0s
[09:03:14.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:22:0)
[09:03:14.733] Timer tick, asking Buildbucket for the build status
[09:03:15.519] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:15.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:23:0) after 1m0s
[09:04:15.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:23:0)
[09:04:15.563] Timer tick, asking Buildbucket for the build status
[09:04:15.626] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:15.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:24:0) after 1m0s
[09:05:15.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:24:0)
[09:05:15.686] Timer tick, asking Buildbucket for the build status
[09:05:15.793] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:15.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:25:0) after 1m0s
[09:06:15.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:25:0)
[09:06:15.808] Timer tick, asking Buildbucket for the build status
[09:06:15.915] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:15.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:26:0) after 1m0s
[09:07:16.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:26:0)
[09:07:16.020] Timer tick, asking Buildbucket for the build status
[09:07:16.093] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:16.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:27:0) after 1m0s
[09:08:16.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:27:0)
[09:08:16.205] Timer tick, asking Buildbucket for the build status
[09:08:16.292] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:16.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:28:0) after 1m0s
[09:09:16.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:28:0)
[09:09:16.349] Timer tick, asking Buildbucket for the build status
[09:09:16.410] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:16.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:29:0) after 1m0s
[09:10:16.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:29:0)
[09:10:16.502] Timer tick, asking Buildbucket for the build status
[09:10:16.632] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:16.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:30:0) after 1m0s
[09:11:16.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:30:0)
[09:11:16.724] Timer tick, asking Buildbucket for the build status
[09:11:16.785] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:16.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:31:0) after 1m0s
[09:12:17.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:31:0)
[09:12:17.306] Timer tick, asking Buildbucket for the build status
[09:12:17.385] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:17.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:32:0) after 1m0s
[09:13:17.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:32:0)
[09:13:17.493] Timer tick, asking Buildbucket for the build status
[09:13:17.566] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:17.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:33:0) after 1m0s
[09:14:17.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:33:0)
[09:14:17.937] Timer tick, asking Buildbucket for the build status
[09:14:18.013] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:18.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:34:0) after 1m0s
[09:15:18.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:34:0)
[09:15:18.202] Timer tick, asking Buildbucket for the build status
[09:15:18.340] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:18.340] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:35:0) after 1m0s
[09:16:18.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:35:0)
[09:16:18.640] Timer tick, asking Buildbucket for the build status
[09:16:18.752] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:18.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:36:0) after 1m0s
[09:17:18.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:36:0)
[09:17:18.964] Timer tick, asking Buildbucket for the build status
[09:17:19.030] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:19.030] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:37:0) after 1m0s
[09:18:19.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:37:0)
[09:18:19.194] Timer tick, asking Buildbucket for the build status
[09:18:19.362] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:19.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:38:0) after 1m0s
[09:19:19.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:38:0)
[09:19:19.411] Timer tick, asking Buildbucket for the build status
[09:19:19.514] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:19.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:39:0) after 1m0s
[09:20:19.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:39:0)
[09:20:19.622] Timer tick, asking Buildbucket for the build status
[09:20:19.754] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:19.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:40:0) after 1m0s
[09:21:19.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:40:0)
[09:21:19.773] Timer tick, asking Buildbucket for the build status
[09:21:19.836] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:19.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:41:0) after 1m0s
[09:22:19.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:41:0)
[09:22:19.967] Timer tick, asking Buildbucket for the build status
[09:22:20.125] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:20.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:42:0) after 1m0s
[09:23:20.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:42:0)
[09:23:20.145] Timer tick, asking Buildbucket for the build status
[09:23:20.228] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:20.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:43:0) after 1m0s
[09:24:20.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:43:0)
[09:24:20.415] Timer tick, asking Buildbucket for the build status
[09:24:20.619] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:20.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:44:0) after 1m0s
[09:25:20.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:44:0)
[09:25:20.733] Timer tick, asking Buildbucket for the build status
[09:25:20.804] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:20.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:45:0) after 1m0s
[09:26:20.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:45:0)
[09:26:20.839] Timer tick, asking Buildbucket for the build status
[09:26:20.891] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:20.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:46:0) after 1m0s
[09:27:20.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:46:0)
[09:27:20.857] Timer tick, asking Buildbucket for the build status
[09:27:20.940] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:20.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:47:0) after 1m0s
[09:28:21.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:47:0)
[09:28:21.004] Timer tick, asking Buildbucket for the build status
[09:28:21.104] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:21.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:48:0) after 1m0s
[09:29:21.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:48:0)
[09:29:21.117] Timer tick, asking Buildbucket for the build status
[09:29:21.363] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:21.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:49:0) after 1m0s
[09:30:21.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:49:0)
[09:30:21.465] Timer tick, asking Buildbucket for the build status
[09:30:21.556] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:21.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:50:0) after 1m0s
[09:31:21.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:50:0)
[09:31:21.621] Timer tick, asking Buildbucket for the build status
[09:31:21.712] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:21.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:51:0) after 1m0s
[09:32:21.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:51:0)
[09:32:21.771] Timer tick, asking Buildbucket for the build status
[09:32:21.858] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:21.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:52:0) after 1m0s
[09:33:21.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:52:0)
[09:33:21.883] Timer tick, asking Buildbucket for the build status
[09:33:22.142] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:22.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:53:0) after 1m0s
[09:34:22.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:53:0)
[09:34:22.178] Timer tick, asking Buildbucket for the build status
[09:34:22.238] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:22.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:54:0) after 1m0s
[09:35:22.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:54:0)
[09:35:22.266] Timer tick, asking Buildbucket for the build status
[09:35:22.338] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:22.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:55:0) after 1m0s
[09:36:22.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:55:0)
[09:36:22.355] Timer tick, asking Buildbucket for the build status
[09:36:22.553] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:22.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:56:0) after 1m0s
[09:37:22.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:56:0)
[09:37:22.581] Timer tick, asking Buildbucket for the build status
[09:37:22.720] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:22.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:57:0) after 1m0s
[09:38:22.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:57:0)
[09:38:22.818] Timer tick, asking Buildbucket for the build status
[09:38:22.896] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:22.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:58:0) after 1m0s
[09:39:22.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:58:0)
[09:39:22.932] Timer tick, asking Buildbucket for the build status
[09:39:23.206] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:23.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:59:0) after 1m0s
[09:40:23.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:59:0)
[09:40:23.261] Timer tick, asking Buildbucket for the build status
[09:40:23.366] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:23.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:60:0) after 1m0s
[09:41:23.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:60:0)
[09:41:23.408] Timer tick, asking Buildbucket for the build status
[09:41:23.494] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:23.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:61:0) after 1m0s
[09:42:23.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:61:0)
[09:42:23.525] Timer tick, asking Buildbucket for the build status
[09:42:23.602] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:23.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:62:0) after 1m0s
[09:43:24.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:62:0)
[09:43:24.569] Timer tick, asking Buildbucket for the build status
[09:43:24.669] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:24.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:63:0) after 1m0s
[09:44:24.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:63:0)
[09:44:24.937] Timer tick, asking Buildbucket for the build status
[09:44:24.997] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:24.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:64:0) after 1m0s
[09:45:25.040] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:64:0)
[09:45:25.040] Timer tick, asking Buildbucket for the build status
[09:45:25.231] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:25.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:65:0) after 1m0s
[09:46:25.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:65:0)
[09:46:25.262] Timer tick, asking Buildbucket for the build status
[09:46:25.335] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:25.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:66:0) after 1m0s
[09:47:27.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:66:0)
[09:47:27.962] Timer tick, asking Buildbucket for the build status
[09:47:28.203] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:28.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:67:0) after 1m0s
[09:48:28.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:67:0)
[09:48:28.247] Timer tick, asking Buildbucket for the build status
[09:48:28.351] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:28.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:68:0) after 1m0s
[09:49:28.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:68:0)
[09:49:28.437] Timer tick, asking Buildbucket for the build status
[09:49:28.499] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:28.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:69:0) after 1m0s
[09:50:28.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:69:0)
[09:50:28.497] Timer tick, asking Buildbucket for the build status
[09:50:28.617] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:28.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:70:0) after 1m0s
[09:51:28.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:70:0)
[09:51:28.709] Timer tick, asking Buildbucket for the build status
[09:51:28.927] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:28.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:71:0) after 1m0s
[09:52:28.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:71:0)
[09:52:28.972] Timer tick, asking Buildbucket for the build status
[09:52:29.050] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:29.050] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:72:0) after 1m0s
[09:53:29.050] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:72:0)
[09:53:29.050] Timer tick, asking Buildbucket for the build status
[09:53:29.116] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:29.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:73:0) after 1m0s
[09:54:29.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:73:0)
[09:54:29.192] Timer tick, asking Buildbucket for the build status
[09:54:29.352] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:29.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:74:0) after 1m0s
[09:55:29.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:74:0)
[09:55:29.393] Timer tick, asking Buildbucket for the build status
[09:55:29.486] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:29.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:75:0) after 1m0s
[09:56:29.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:75:0)
[09:56:29.582] Timer tick, asking Buildbucket for the build status
[09:56:29.997] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:29.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:76:0) after 1m0s
[09:57:30.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:76:0)
[09:57:30.054] Timer tick, asking Buildbucket for the build status
[09:57:30.111] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:30.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:77:0) after 1m0s
[09:58:30.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:77:0)
[09:58:30.248] Timer tick, asking Buildbucket for the build status
[09:58:30.334] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:30.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:78:0) after 1m0s
[09:59:30.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:78:0)
[09:59:30.489] Timer tick, asking Buildbucket for the build status
[09:59:30.589] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:30.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:79:0) after 1m0s
[10:00:30.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:79:0)
[10:00:30.651] Timer tick, asking Buildbucket for the build status
[10:00:30.719] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:30.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:80:0) after 1m0s
[10:01:30.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:80:0)
[10:01:30.736] Timer tick, asking Buildbucket for the build status
[10:01:30.996] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:30.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:81:0) after 1m0s
[10:02:31.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:81:0)
[10:02:31.069] Timer tick, asking Buildbucket for the build status
[10:02:31.249] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:31.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:82:0) after 1m0s
[10:03:31.300] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:82:0)
[10:03:31.300] Timer tick, asking Buildbucket for the build status
[10:03:31.444] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:31.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:83:0) after 1m0s
[10:04:31.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:83:0)
[10:04:31.547] Timer tick, asking Buildbucket for the build status
[10:04:31.620] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:31.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:84:0) after 1m0s
[10:05:31.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:84:0)
[10:05:31.645] Timer tick, asking Buildbucket for the build status
[10:05:31.709] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:31.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:85:0) after 1m0s
[10:06:31.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:85:0)
[10:06:31.701] Timer tick, asking Buildbucket for the build status
[10:06:31.766] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:31.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:86:0) after 1m0s
[10:07:31.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:86:0)
[10:07:31.785] Timer tick, asking Buildbucket for the build status
[10:07:31.855] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:31.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:87:0) after 1m0s
[10:08:31.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:87:0)
[10:08:31.869] Timer tick, asking Buildbucket for the build status
[10:08:31.955] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:31.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:88:0) after 1m0s
[10:09:31.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:88:0)
[10:09:31.993] Timer tick, asking Buildbucket for the build status
[10:09:32.223] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:32.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:89:0) after 1m0s
[10:10:32.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:89:0)
[10:10:32.320] Timer tick, asking Buildbucket for the build status
[10:10:32.381] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:32.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:90:0) after 1m0s
[10:11:32.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:90:0)
[10:11:32.507] Timer tick, asking Buildbucket for the build status
[10:11:32.582] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:32.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:91:0) after 1m0s
[10:12:32.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:91:0)
[10:12:32.618] Timer tick, asking Buildbucket for the build status
[10:12:32.738] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:32.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:92:0) after 1m0s
[10:13:32.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:92:0)
[10:13:32.790] Timer tick, asking Buildbucket for the build status
[10:13:32.947] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:32.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:93:0) after 1m0s
[10:14:32.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:93:0)
[10:14:32.976] Timer tick, asking Buildbucket for the build status
[10:14:33.121] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:33.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:94:0) after 1m0s
[10:15:33.180] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:94:0)
[10:15:33.180] Timer tick, asking Buildbucket for the build status
[10:15:33.426] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:33.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:95:0) after 1m0s
[10:16:33.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:95:0)
[10:16:33.526] Timer tick, asking Buildbucket for the build status
[10:16:33.604] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:33.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:96:0) after 1m0s
[10:17:33.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:96:0)
[10:17:33.635] Timer tick, asking Buildbucket for the build status
[10:17:33.704] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:33.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:97:0) after 1m0s
[10:18:33.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:97:0)
[10:18:33.730] Timer tick, asking Buildbucket for the build status
[10:18:33.807] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:33.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:98:0) after 1m0s
[10:19:33.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:98:0)
[10:19:33.859] Timer tick, asking Buildbucket for the build status
[10:19:33.951] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:33.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:99:0) after 1m0s
[10:20:33.926] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:99:0)
[10:20:33.926] Timer tick, asking Buildbucket for the build status
[10:20:33.983] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:33.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:100:0) after 1m0s
[10:21:34.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:100:0)
[10:21:34.051] Timer tick, asking Buildbucket for the build status
[10:21:34.132] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:34.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:101:0) after 1m0s
[10:22:34.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:101:0)
[10:22:34.156] Timer tick, asking Buildbucket for the build status
[10:22:34.247] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:34.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:102:0) after 1m0s
[10:23:34.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:102:0)
[10:23:34.284] Timer tick, asking Buildbucket for the build status
[10:23:34.364] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:34.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:103:0) after 1m0s
[10:24:34.332] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:103:0)
[10:24:34.332] Timer tick, asking Buildbucket for the build status
[10:24:34.385] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:34.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:104:0) after 1m0s
[10:25:34.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:104:0)
[10:25:34.408] Timer tick, asking Buildbucket for the build status
[10:25:34.465] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:34.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:105:0) after 1m0s
[10:26:34.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:105:0)
[10:26:34.544] Timer tick, asking Buildbucket for the build status
[10:26:34.601] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:34.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:106:0) after 1m0s
[10:27:34.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:106:0)
[10:27:34.740] Timer tick, asking Buildbucket for the build status
[10:27:34.802] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:34.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:107:0) after 1m0s
[10:28:34.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:107:0)
[10:28:34.917] Timer tick, asking Buildbucket for the build status
[10:28:35.156] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:35.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:108:0) after 1m0s
[10:29:35.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:108:0)
[10:29:35.249] Timer tick, asking Buildbucket for the build status
[10:29:35.319] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:35.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:109:0) after 1m0s
[10:30:35.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:109:0)
[10:30:35.340] Timer tick, asking Buildbucket for the build status
[10:30:35.457] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:35.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:110:0) after 1m0s
[10:31:35.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:110:0)
[10:31:35.548] Timer tick, asking Buildbucket for the build status
[10:31:35.635] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:35.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:111:0) after 1m0s
[10:32:35.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:111:0)
[10:32:35.760] Timer tick, asking Buildbucket for the build status
[10:32:35.870] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:35.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:112:0) after 1m0s
[10:33:35.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:112:0)
[10:33:35.948] Timer tick, asking Buildbucket for the build status
[10:33:36.081] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:36.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:113:0) after 1m0s
[10:34:36.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:113:0)
[10:34:36.133] Timer tick, asking Buildbucket for the build status
[10:34:36.192] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:36.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:114:0) after 1m0s
[10:35:36.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:114:0)
[10:35:36.311] Timer tick, asking Buildbucket for the build status
[10:35:36.373] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:36.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:115:0) after 1m0s
[10:36:36.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:115:0)
[10:36:36.424] Timer tick, asking Buildbucket for the build status
[10:36:36.506] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:36.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:116:0) after 1m0s
[10:37:36.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:116:0)
[10:37:36.588] Timer tick, asking Buildbucket for the build status
[10:37:36.673] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:36.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:117:0) after 1m0s
[10:38:36.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:117:0)
[10:38:36.763] Timer tick, asking Buildbucket for the build status
[10:38:36.874] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:36.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:118:0) after 1m0s
[10:39:36.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:118:0)
[10:39:36.887] Timer tick, asking Buildbucket for the build status
[10:39:36.958] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:36.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:119:0) after 1m0s
[10:40:37.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:119:0)
[10:40:37.076] Timer tick, asking Buildbucket for the build status
[10:40:37.263] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:37.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:120:0) after 1m0s
[10:41:37.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:120:0)
[10:41:37.241] Timer tick, asking Buildbucket for the build status
[10:41:38.174] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:38.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:121:0) after 1m0s
[10:42:38.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:121:0)
[10:42:38.303] Timer tick, asking Buildbucket for the build status
[10:42:38.370] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:38.370] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:122:0) after 1m0s
[10:43:38.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:122:0)
[10:43:38.563] Timer tick, asking Buildbucket for the build status
[10:43:38.642] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:38.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:123:0) after 1m0s
[10:44:38.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:123:0)
[10:44:38.711] Timer tick, asking Buildbucket for the build status
[10:44:38.805] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:38.805] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:124:0) after 1m0s
[10:45:39.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:124:0)
[10:45:39.431] Timer tick, asking Buildbucket for the build status
[10:45:39.493] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:39.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:125:0) after 1m0s
[10:46:39.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:125:0)
[10:46:39.537] Timer tick, asking Buildbucket for the build status
[10:46:39.601] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:39.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:126:0) after 1m0s
[10:47:39.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:126:0)
[10:47:39.721] Timer tick, asking Buildbucket for the build status
[10:47:39.778] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:39.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:127:0) after 1m0s
[10:48:39.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:127:0)
[10:48:39.839] Timer tick, asking Buildbucket for the build status
[10:48:39.937] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:39.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:128:0) after 1m0s
[10:49:40.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:128:0)
[10:49:40.026] Timer tick, asking Buildbucket for the build status
[10:49:40.107] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:40.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:129:0) after 1m0s
[10:50:40.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:129:0)
[10:50:40.165] Timer tick, asking Buildbucket for the build status
[10:50:40.663] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:40.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:130:0) after 1m0s
[10:51:40.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:130:0)
[10:51:40.752] Timer tick, asking Buildbucket for the build status
[10:51:40.809] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:40.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:131:0) after 1m0s
[10:52:40.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:131:0)
[10:52:40.924] Timer tick, asking Buildbucket for the build status
[10:52:41.163] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:41.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:132:0) after 1m0s
[10:53:41.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:132:0)
[10:53:41.254] Timer tick, asking Buildbucket for the build status
[10:53:43.639] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:43.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:133:0) after 1m0s
[10:54:43.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:133:0)
[10:54:43.611] Timer tick, asking Buildbucket for the build status
[10:54:43.911] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:43.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:134:0) after 1m0s
[10:55:43.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:134:0)
[10:55:43.902] Timer tick, asking Buildbucket for the build status
[10:55:44.008] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:44.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:135:0) after 1m0s
[10:56:44.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:135:0)
[10:56:44.027] Timer tick, asking Buildbucket for the build status
[10:56:44.268] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:44.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:136:0) after 1m0s
[10:57:44.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:136:0)
[10:57:44.285] Timer tick, asking Buildbucket for the build status
[10:57:44.356] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:44.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:137:0) after 1m0s
[10:58:44.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:137:0)
[10:58:44.405] Timer tick, asking Buildbucket for the build status
[10:58:44.484] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:44.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:138:0) after 1m0s
[10:59:44.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:138:0)
[10:59:44.575] Timer tick, asking Buildbucket for the build status
[10:59:44.733] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:44.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:139:0) after 1m0s
[11:00:44.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:139:0)
[11:00:44.755] Timer tick, asking Buildbucket for the build status
[11:00:44.824] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:44.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:140:0) after 1m0s
[11:01:44.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:140:0)
[11:01:44.853] Timer tick, asking Buildbucket for the build status
[11:01:44.911] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:44.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:141:0) after 1m0s
[11:02:44.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:141:0)
[11:02:44.994] Timer tick, asking Buildbucket for the build status
[11:02:45.074] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:45.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:142:0) after 1m0s
[11:03:45.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:142:0)
[11:03:45.206] Timer tick, asking Buildbucket for the build status
[11:03:45.288] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:45.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:143:0) after 1m0s
[11:04:45.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:143:0)
[11:04:45.316] Timer tick, asking Buildbucket for the build status
[11:04:45.398] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:45.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:144:0) after 1m0s
[11:05:45.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:144:0)
[11:05:45.448] Timer tick, asking Buildbucket for the build status
[11:05:45.976] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:45.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:145:0) after 1m0s
[11:06:46.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:145:0)
[11:06:46.169] Timer tick, asking Buildbucket for the build status
[11:06:51.360] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:51.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:146:0) after 1m0s
[11:07:51.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:146:0)
[11:07:51.425] Timer tick, asking Buildbucket for the build status
[11:07:51.498] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:51.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:147:0) after 1m0s
[11:08:51.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:147:0)
[11:08:51.563] Timer tick, asking Buildbucket for the build status
[11:08:51.767] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:51.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:148:0) after 1m0s
[11:09:51.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:148:0)
[11:09:51.809] Timer tick, asking Buildbucket for the build status
[11:09:51.877] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:51.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:149:0) after 1m0s
[11:10:51.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:149:0)
[11:10:51.866] Timer tick, asking Buildbucket for the build status
[11:10:52.090] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:52.090] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:150:0) after 1m0s
[11:11:52.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:150:0)
[11:11:52.145] Timer tick, asking Buildbucket for the build status
[11:11:52.215] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:52.215] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:151:0) after 1m0s
[11:12:52.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:151:0)
[11:12:52.196] Timer tick, asking Buildbucket for the build status
[11:12:52.262] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:52.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:152:0) after 1m0s
[11:13:52.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:152:0)
[11:13:52.322] Timer tick, asking Buildbucket for the build status
[11:13:52.542] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:52.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:153:0) after 1m0s
[11:14:52.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:153:0)
[11:14:52.563] Timer tick, asking Buildbucket for the build status
[11:14:52.629] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:52.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:154:0) after 1m0s
[11:15:52.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:154:0)
[11:15:52.655] Timer tick, asking Buildbucket for the build status
[11:15:52.835] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:52.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:155:0) after 1m0s
[11:16:52.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:155:0)
[11:16:52.909] Timer tick, asking Buildbucket for the build status
[11:16:53.111] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:53.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:156:0) after 1m0s
[11:17:53.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:156:0)
[11:17:53.165] Timer tick, asking Buildbucket for the build status
[11:17:53.227] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:53.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:157:0) after 1m0s
[11:18:53.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:157:0)
[11:18:53.325] Timer tick, asking Buildbucket for the build status
[11:18:53.500] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:53.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:158:0) after 1m0s
[11:19:53.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:158:0)
[11:19:53.532] Timer tick, asking Buildbucket for the build status
[11:19:53.644] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:53.644] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:159:0) after 1m0s
[11:20:53.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:159:0)
[11:20:53.668] Timer tick, asking Buildbucket for the build status
[11:20:53.754] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:53.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:160:0) after 1m0s
[11:21:53.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:160:0)
[11:21:53.802] Timer tick, asking Buildbucket for the build status
[11:21:54.434] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:54.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:161:0) after 1m0s
[11:22:54.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:161:0)
[11:22:54.458] Timer tick, asking Buildbucket for the build status
[11:22:54.540] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:54.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:162:0) after 1m0s
[11:23:54.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:162:0)
[11:23:54.562] Timer tick, asking Buildbucket for the build status
[11:23:54.635] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:54.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:163:0) after 1m0s
[11:24:54.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:163:0)
[11:24:54.721] Timer tick, asking Buildbucket for the build status
[11:24:55.400] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:55.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:164:0) after 1m0s
[11:25:55.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:164:0)
[11:25:55.480] Timer tick, asking Buildbucket for the build status
[11:25:55.565] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:55.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:165:0) after 1m0s
[11:26:55.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:165:0)
[11:26:55.652] Timer tick, asking Buildbucket for the build status
[11:26:55.744] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:55.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:166:0) after 1m0s
[11:27:55.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:166:0)
[11:27:55.815] Timer tick, asking Buildbucket for the build status
[11:27:56.023] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:56.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:167:0) after 1m0s
[11:28:56.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:167:0)
[11:28:56.053] Timer tick, asking Buildbucket for the build status
[11:28:56.127] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:56.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:168:0) after 1m0s
[11:29:56.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:168:0)
[11:29:56.172] Timer tick, asking Buildbucket for the build status
[11:29:56.429] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:56.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:169:0) after 1m0s
[11:30:56.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:169:0)
[11:30:56.514] Timer tick, asking Buildbucket for the build status
[11:30:56.650] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:56.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:170:0) after 1m0s
[11:31:56.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:170:0)
[11:31:56.671] Timer tick, asking Buildbucket for the build status
[11:31:57.222] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:57.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:171:0) after 1m0s
[11:32:57.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:171:0)
[11:32:57.242] Timer tick, asking Buildbucket for the build status
[11:32:57.731] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:57.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:172:0) after 1m0s
[11:33:57.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:172:0)
[11:33:57.757] Timer tick, asking Buildbucket for the build status
[11:33:57.842] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:57.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:173:0) after 1m0s
[11:34:57.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:173:0)
[11:34:57.897] Timer tick, asking Buildbucket for the build status
[11:34:58.058] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:58.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:174:0) after 1m0s
[11:35:58.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:174:0)
[11:35:58.113] Timer tick, asking Buildbucket for the build status
[11:35:58.201] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:58.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:175:0) after 1m0s
[11:36:58.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:175:0)
[11:36:58.264] Timer tick, asking Buildbucket for the build status
[11:36:58.334] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:58.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:176:0) after 1m0s
[11:37:58.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:176:0)
[11:37:58.354] Timer tick, asking Buildbucket for the build status
[11:37:58.462] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:58.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:177:0) after 1m0s
[11:38:58.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:177:0)
[11:38:58.517] Timer tick, asking Buildbucket for the build status
[11:38:58.590] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:58.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:178:0) after 1m0s
[11:39:58.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:178:0)
[11:39:58.631] Timer tick, asking Buildbucket for the build status
[11:39:58.773] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:58.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:179:0) after 1m0s
[11:40:58.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:179:0)
[11:40:58.845] Timer tick, asking Buildbucket for the build status
[11:40:59.307] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:59.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:180:0) after 1m0s
[11:41:59.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:180:0)
[11:41:59.336] Timer tick, asking Buildbucket for the build status
[11:41:59.407] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:59.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:181:0) after 1m0s
[11:42:59.443] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:181:0)
[11:42:59.443] Timer tick, asking Buildbucket for the build status
[11:42:59.505] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:59.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:182:0) after 1m0s
[11:43:59.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:182:0)
[11:43:59.532] Timer tick, asking Buildbucket for the build status
[11:43:59.592] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:59.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:183:0) after 1m0s
[11:44:59.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:183:0)
[11:44:59.682] Timer tick, asking Buildbucket for the build status
[11:45:00.210] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:00.210] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:184:0) after 1m0s
[11:46:00.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:184:0)
[11:46:00.226] Timer tick, asking Buildbucket for the build status
[11:46:00.854] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:00.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:185:0) after 1m0s
[11:47:01.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:185:0)
[11:47:01.068] Timer tick, asking Buildbucket for the build status
[11:47:01.303] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:01.303] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:186:0) after 1m0s
[11:48:01.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:186:0)
[11:48:01.303] Timer tick, asking Buildbucket for the build status
[11:48:01.595] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:01.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:187:0) after 1m0s
[11:49:01.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:187:0)
[11:49:01.699] Timer tick, asking Buildbucket for the build status
[11:49:01.756] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:01.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:188:0) after 1m0s
[11:50:01.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:188:0)
[11:50:01.804] Timer tick, asking Buildbucket for the build status
[11:50:01.926] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:01.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:189:0) after 1m0s
[11:51:01.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:189:0)
[11:51:01.997] Timer tick, asking Buildbucket for the build status
[11:51:02.116] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:02.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:190:0) after 1m0s
[11:52:02.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:190:0)
[11:52:02.138] Timer tick, asking Buildbucket for the build status
[11:52:02.316] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:02.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:191:0) after 1m0s
[11:53:02.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:191:0)
[11:53:02.338] Timer tick, asking Buildbucket for the build status
[11:53:02.448] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:02.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:192:0) after 1m0s
[11:54:02.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:192:0)
[11:54:02.469] Timer tick, asking Buildbucket for the build status
[11:54:02.550] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:02.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:193:0) after 1m0s
[11:55:02.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:193:0)
[11:55:02.632] Timer tick, asking Buildbucket for the build status
[11:55:02.719] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:02.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:194:0) after 1m0s
[11:56:02.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:194:0)
[11:56:02.766] Timer tick, asking Buildbucket for the build status
[11:56:02.834] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:02.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:195:0) after 1m0s
[11:57:02.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:195:0)
[11:57:02.934] Timer tick, asking Buildbucket for the build status
[11:57:03.050] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:03.051] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:196:0) after 1m0s
[11:58:03.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:196:0)
[11:58:03.253] Timer tick, asking Buildbucket for the build status
[11:58:03.316] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:03.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:197:0) after 1m0s
[11:59:03.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:197:0)
[11:59:03.347] Timer tick, asking Buildbucket for the build status
[11:59:03.445] Build 8853341113932058144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:03.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9018771175929104336:198:0) after 1m0s
[11:59:27.369] Received PubSub notification, asking Buildbucket for the build status
[11:59:27.432] Build 8853341113932058144: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:59:27.432] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1615204767141823",
"created_by": "project:infra",
"created_ts": "1615192987467599",
"id": "8853341113932058144",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"91.0.4440.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9bc026ac-9d38-46e6-878c-344ea6f97c37\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"91.0.4440.0\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-fotl\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5744-5c0a4b4\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615193041837340",
"status": "COMPLETED",
"status_changed_ts": "1615193042326877",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9018771175929104336",
"scheduler_job_id:infra/Build From Tarball",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8853341113932058144/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:build_from_tarball",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_task_id:5229d2a280536610",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1615204767142223",
"url": "https://ci.chromium.org/b/8853341113932058144",
"utcnow_ts": "1615204767426325"
}
}
[11:59:27.432] Invocation finished in 3h16m21.253253183s with status SUCCEEDED