[22:55:16.626] New invocation is queued and will start shortly
[22:55:16.626] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[22:55:18.011] Starting the invocation (attempt 1)
[22:55:18.082] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:55:18.082] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:55:18.082] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9050879484908233168",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"82.0.4085.12\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"92c0b2f5-b6ec-4c69-8712-5474fe30f7af\",\"title\":\"publish_tarball/0\"}]},\"version\":\"82.0.4085.12\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9050879484908233168",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[22:55:20.926] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1584572118297250",
"id": "8885449422442679024",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"82.0.4085.12\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"92c0b2f5-b6ec-4c69-8712-5474fe30f7af\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"82.0.4085.12\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1584572119859960",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9050879484908233168",
"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/8885449422442679024/+/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": "1584572119860195",
"url": "https://ci.chromium.org/b/8885449422442679024",
"utcnow_ts": "1584572120889605"
}
}
[22:55:20.926] Task URL: https://ci.chromium.org/b/8885449422442679024
[22:55:20.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:2:0) after 1m0s
[22:56:20.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:2:0)
[22:56:20.942] Timer tick, asking Buildbucket for the build status
[22:56:21.175] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:21.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:3:0) after 1m0s
[22:57:21.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:3:0)
[22:57:21.324] Timer tick, asking Buildbucket for the build status
[22:57:21.478] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:21.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:4:0) after 1m0s
[22:58:21.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:4:0)
[22:58:21.536] Timer tick, asking Buildbucket for the build status
[22:58:21.727] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:21.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:5:0) after 1m0s
[22:59:21.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:5:0)
[22:59:21.816] Timer tick, asking Buildbucket for the build status
[22:59:21.989] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:21.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:6:0) after 1m0s
[23:00:22.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:6:0)
[23:00:22.107] Timer tick, asking Buildbucket for the build status
[23:00:22.239] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:22.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:7:0) after 1m0s
[23:01:22.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:7:0)
[23:01:22.282] Timer tick, asking Buildbucket for the build status
[23:01:23.079] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:23.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:8:0) after 1m0s
[23:02:23.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:8:0)
[23:02:23.160] Timer tick, asking Buildbucket for the build status
[23:02:23.407] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:23.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:9:0) after 1m0s
[23:03:23.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:9:0)
[23:03:23.496] Timer tick, asking Buildbucket for the build status
[23:03:23.679] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:23.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:10:0) after 1m0s
[23:04:23.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:10:0)
[23:04:23.696] Timer tick, asking Buildbucket for the build status
[23:04:24.005] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:24.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:11:0) after 1m0s
[23:05:24.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:11:0)
[23:05:24.058] Timer tick, asking Buildbucket for the build status
[23:05:24.310] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:24.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:12:0) after 1m0s
[23:06:24.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:12:0)
[23:06:24.392] Timer tick, asking Buildbucket for the build status
[23:06:24.801] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:24.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:13:0) after 1m0s
[23:07:24.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:13:0)
[23:07:24.854] Timer tick, asking Buildbucket for the build status
[23:07:26.196] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:26.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:14:0) after 1m0s
[23:08:26.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:14:0)
[23:08:26.301] Timer tick, asking Buildbucket for the build status
[23:08:26.939] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:08:26.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:15:0) after 1m0s
[23:09:27.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:15:0)
[23:09:27.014] Timer tick, asking Buildbucket for the build status
[23:09:27.158] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:09:27.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:16:0) after 1m0s
[23:10:27.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:16:0)
[23:10:27.312] Timer tick, asking Buildbucket for the build status
[23:10:27.424] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:27.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:17:0) after 1m0s
[23:11:27.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:17:0)
[23:11:27.542] Timer tick, asking Buildbucket for the build status
[23:11:29.251] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:29.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:18:0) after 1m0s
[23:12:29.280] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:18:0)
[23:12:29.280] Timer tick, asking Buildbucket for the build status
[23:12:29.585] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:29.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:19:0) after 1m0s
[23:13:29.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:19:0)
[23:13:29.604] Timer tick, asking Buildbucket for the build status
[23:13:30.008] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:30.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:20:0) after 1m0s
[23:14:30.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:20:0)
[23:14:30.039] Timer tick, asking Buildbucket for the build status
[23:14:32.159] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:32.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:21:0) after 1m0s
[23:15:32.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:21:0)
[23:15:32.181] Timer tick, asking Buildbucket for the build status
[23:15:32.376] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:32.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:22:0) after 1m0s
[23:16:32.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:22:0)
[23:16:32.377] Timer tick, asking Buildbucket for the build status
[23:16:33.223] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:33.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:23:0) after 1m0s
[23:17:33.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:23:0)
[23:17:33.256] Timer tick, asking Buildbucket for the build status
[23:17:33.729] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:33.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:24:0) after 1m0s
[23:18:33.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:24:0)
[23:18:33.762] Timer tick, asking Buildbucket for the build status
[23:18:34.062] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:34.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:25:0) after 1m0s
[23:19:34.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:25:0)
[23:19:34.099] Timer tick, asking Buildbucket for the build status
[23:19:34.767] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:34.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:26:0) after 1m0s
[23:20:34.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:26:0)
[23:20:34.791] Timer tick, asking Buildbucket for the build status
[23:20:34.890] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:34.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:27:0) after 1m0s
[23:21:34.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:27:0)
[23:21:34.963] Timer tick, asking Buildbucket for the build status
[23:21:36.823] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:36.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:28:0) after 1m0s
[23:22:36.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:28:0)
[23:22:36.858] Timer tick, asking Buildbucket for the build status
[23:22:36.954] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:36.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:29:0) after 1m0s
[23:23:37.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:29:0)
[23:23:37.033] Timer tick, asking Buildbucket for the build status
[23:23:37.188] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:37.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:30:0) after 1m0s
[23:24:37.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:30:0)
[23:24:37.211] Timer tick, asking Buildbucket for the build status
[23:24:37.426] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:37.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:31:0) after 1m0s
[23:25:37.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:31:0)
[23:25:37.450] Timer tick, asking Buildbucket for the build status
[23:25:37.574] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:37.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:32:0) after 1m0s
[23:26:37.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:32:0)
[23:26:37.575] Timer tick, asking Buildbucket for the build status
[23:26:38.646] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:38.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:33:0) after 1m0s
[23:27:38.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:33:0)
[23:27:38.710] Timer tick, asking Buildbucket for the build status
[23:27:38.879] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:38.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:34:0) after 1m0s
[23:28:38.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:34:0)
[23:28:38.962] Timer tick, asking Buildbucket for the build status
[23:28:40.352] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:40.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:35:0) after 1m0s
[23:29:40.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:35:0)
[23:29:40.489] Timer tick, asking Buildbucket for the build status
[23:29:40.893] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:40.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:36:0) after 1m0s
[23:30:40.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:36:0)
[23:30:40.965] Timer tick, asking Buildbucket for the build status
[23:30:41.249] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:41.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:37:0) after 1m0s
[23:31:41.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:37:0)
[23:31:41.282] Timer tick, asking Buildbucket for the build status
[23:31:41.846] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:41.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:38:0) after 1m0s
[23:32:41.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:38:0)
[23:32:41.871] Timer tick, asking Buildbucket for the build status
[23:32:42.147] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:42.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:39:0) after 1m0s
[23:33:42.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:39:0)
[23:33:42.197] Timer tick, asking Buildbucket for the build status
[23:33:42.724] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:42.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:40:0) after 1m0s
[23:34:42.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:40:0)
[23:34:42.758] Timer tick, asking Buildbucket for the build status
[23:34:43.574] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:43.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:41:0) after 1m0s
[23:35:43.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:41:0)
[23:35:43.690] Timer tick, asking Buildbucket for the build status
[23:35:43.885] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:43.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:42:0) after 1m0s
[23:36:43.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:42:0)
[23:36:43.882] Timer tick, asking Buildbucket for the build status
[23:36:45.024] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:45.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:43:0) after 1m0s
[23:37:45.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:43:0)
[23:37:45.071] Timer tick, asking Buildbucket for the build status
[23:37:45.247] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:45.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:44:0) after 1m0s
[23:38:45.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:44:0)
[23:38:45.259] Timer tick, asking Buildbucket for the build status
[23:38:45.579] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:45.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:45:0) after 1m0s
[23:39:45.598] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:45:0)
[23:39:45.598] Timer tick, asking Buildbucket for the build status
[23:39:45.913] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:45.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:46:0) after 1m0s
[23:40:45.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:46:0)
[23:40:45.897] Timer tick, asking Buildbucket for the build status
[23:40:46.718] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:46.718] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:47:0) after 1m0s
[23:41:46.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:47:0)
[23:41:46.752] Timer tick, asking Buildbucket for the build status
[23:41:46.876] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:46.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:48:0) after 1m0s
[23:42:47.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:48:0)
[23:42:47.001] Timer tick, asking Buildbucket for the build status
[23:42:47.181] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:47.181] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:49:0) after 1m0s
[23:43:47.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:49:0)
[23:43:47.297] Timer tick, asking Buildbucket for the build status
[23:43:47.684] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:47.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:50:0) after 1m0s
[23:44:47.781] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:50:0)
[23:44:47.781] Timer tick, asking Buildbucket for the build status
[23:44:48.049] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:48.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:51:0) after 1m0s
[23:45:48.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:51:0)
[23:45:48.154] Timer tick, asking Buildbucket for the build status
[23:45:48.317] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:48.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:52:0) after 1m0s
[23:46:48.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:52:0)
[23:46:48.337] Timer tick, asking Buildbucket for the build status
[23:46:48.677] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:48.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:53:0) after 1m0s
[23:47:48.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:53:0)
[23:47:48.688] Timer tick, asking Buildbucket for the build status
[23:47:48.812] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:48.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:54:0) after 1m0s
[23:48:48.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:54:0)
[23:48:48.910] Timer tick, asking Buildbucket for the build status
[23:48:49.284] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:49.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:55:0) after 1m0s
[23:49:49.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:55:0)
[23:49:49.453] Timer tick, asking Buildbucket for the build status
[23:49:49.549] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:49.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:56:0) after 1m0s
[23:50:49.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:56:0)
[23:50:49.664] Timer tick, asking Buildbucket for the build status
[23:50:51.892] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:51.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:57:0) after 1m0s
[23:51:52.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:57:0)
[23:51:52.000] Timer tick, asking Buildbucket for the build status
[23:51:52.215] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:52.215] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:58:0) after 1m0s
[23:52:52.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:58:0)
[23:52:52.994] Timer tick, asking Buildbucket for the build status
[23:52:53.264] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:53.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:59:0) after 1m0s
[23:53:53.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:59:0)
[23:53:53.497] Timer tick, asking Buildbucket for the build status
[23:53:53.631] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:53.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:60:0) after 1m0s
[23:54:54.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:60:0)
[23:54:54.418] Timer tick, asking Buildbucket for the build status
[23:54:54.574] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:54.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:61:0) after 1m0s
[23:55:54.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:61:0)
[23:55:54.711] Timer tick, asking Buildbucket for the build status
[23:55:54.855] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:54.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:62:0) after 1m0s
[23:56:55.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:62:0)
[23:56:55.008] Timer tick, asking Buildbucket for the build status
[23:56:55.745] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:55.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:63:0) after 1m0s
[23:57:56.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:63:0)
[23:57:56.164] Timer tick, asking Buildbucket for the build status
[23:57:56.453] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:56.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:64:0) after 1m0s
[23:58:56.844] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:64:0)
[23:58:56.844] Timer tick, asking Buildbucket for the build status
[23:58:57.199] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:57.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:65:0) after 1m0s
[23:59:57.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:65:0)
[23:59:57.414] Timer tick, asking Buildbucket for the build status
[23:59:57.638] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:57.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:66:0) after 1m0s
[00:00:57.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:66:0)
[00:00:57.832] Timer tick, asking Buildbucket for the build status
[00:00:58.217] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:58.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:67:0) after 1m0s
[00:01:58.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:67:0)
[00:01:58.253] Timer tick, asking Buildbucket for the build status
[00:01:58.692] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:58.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:68:0) after 1m0s
[00:02:58.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:68:0)
[00:02:58.719] Timer tick, asking Buildbucket for the build status
[00:02:58.891] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:58.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:69:0) after 1m0s
[00:03:59.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:69:0)
[00:03:59.057] Timer tick, asking Buildbucket for the build status
[00:03:59.732] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:59.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:70:0) after 1m0s
[00:04:59.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:70:0)
[00:04:59.828] Timer tick, asking Buildbucket for the build status
[00:05:00.128] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:00.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:71:0) after 1m0s
[00:06:00.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:71:0)
[00:06:00.157] Timer tick, asking Buildbucket for the build status
[00:06:00.435] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:00.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:72:0) after 1m0s
[00:07:00.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:72:0)
[00:07:00.462] Timer tick, asking Buildbucket for the build status
[00:07:00.686] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:00.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:73:0) after 1m0s
[00:08:00.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:73:0)
[00:08:00.833] Timer tick, asking Buildbucket for the build status
[00:08:01.132] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:01.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:74:0) after 1m0s
[00:09:01.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:74:0)
[00:09:01.150] Timer tick, asking Buildbucket for the build status
[00:09:01.342] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:01.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:75:0) after 1m0s
[00:10:01.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:75:0)
[00:10:01.426] Timer tick, asking Buildbucket for the build status
[00:10:01.632] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:01.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:76:0) after 1m0s
[00:11:01.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:76:0)
[00:11:01.704] Timer tick, asking Buildbucket for the build status
[00:11:02.191] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:02.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:77:0) after 1m0s
[00:12:02.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:77:0)
[00:12:02.250] Timer tick, asking Buildbucket for the build status
[00:12:02.876] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:02.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:78:0) after 1m0s
[00:13:02.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:78:0)
[00:13:02.890] Timer tick, asking Buildbucket for the build status
[00:13:03.841] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:03.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:79:0) after 1m0s
[00:14:03.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:79:0)
[00:14:03.863] Timer tick, asking Buildbucket for the build status
[00:14:04.315] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:04.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:80:0) after 1m0s
[00:15:04.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:80:0)
[00:15:04.365] Timer tick, asking Buildbucket for the build status
[00:15:04.700] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:04.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:81:0) after 1m0s
[00:16:04.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:81:0)
[00:16:04.730] Timer tick, asking Buildbucket for the build status
[00:16:05.089] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:05.089] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:82:0) after 1m0s
[00:17:05.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:82:0)
[00:17:05.221] Timer tick, asking Buildbucket for the build status
[00:17:05.552] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:05.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:83:0) after 1m0s
[00:18:05.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:83:0)
[00:18:05.593] Timer tick, asking Buildbucket for the build status
[00:18:05.676] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:05.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:84:0) after 1m0s
[00:19:05.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:84:0)
[00:19:05.701] Timer tick, asking Buildbucket for the build status
[00:19:06.211] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:06.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:85:0) after 1m0s
[00:20:06.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:85:0)
[00:20:06.223] Timer tick, asking Buildbucket for the build status
[00:20:06.503] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:06.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:86:0) after 1m0s
[00:21:06.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:86:0)
[00:21:06.559] Timer tick, asking Buildbucket for the build status
[00:21:06.793] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:06.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:87:0) after 1m0s
[00:22:06.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:87:0)
[00:22:06.817] Timer tick, asking Buildbucket for the build status
[00:22:06.989] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:06.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:88:0) after 1m0s
[00:23:07.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:88:0)
[00:23:07.038] Timer tick, asking Buildbucket for the build status
[00:23:07.649] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:07.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:89:0) after 1m0s
[00:24:07.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:89:0)
[00:24:07.725] Timer tick, asking Buildbucket for the build status
[00:24:07.871] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:07.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:90:0) after 1m0s
[00:25:07.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:90:0)
[00:25:07.934] Timer tick, asking Buildbucket for the build status
[00:25:08.083] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:08.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:91:0) after 1m0s
[00:26:08.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:91:0)
[00:26:08.160] Timer tick, asking Buildbucket for the build status
[00:26:08.270] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:08.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:92:0) after 1m0s
[00:27:08.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:92:0)
[00:27:08.429] Timer tick, asking Buildbucket for the build status
[00:27:08.636] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:08.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:93:0) after 1m0s
[00:28:08.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:93:0)
[00:28:08.703] Timer tick, asking Buildbucket for the build status
[00:28:09.920] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:09.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:94:0) after 1m0s
[00:29:09.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:94:0)
[00:29:09.919] Timer tick, asking Buildbucket for the build status
[00:29:10.158] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:10.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:95:0) after 1m0s
[00:30:10.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:95:0)
[00:30:10.182] Timer tick, asking Buildbucket for the build status
[00:30:10.708] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:10.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:96:0) after 1m0s
[00:31:10.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:96:0)
[00:31:10.747] Timer tick, asking Buildbucket for the build status
[00:31:10.981] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:10.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:97:0) after 1m0s
[00:32:11.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:97:0)
[00:32:11.022] Timer tick, asking Buildbucket for the build status
[00:32:11.301] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:11.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:98:0) after 1m0s
[00:33:11.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:98:0)
[00:33:11.347] Timer tick, asking Buildbucket for the build status
[00:33:11.843] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:11.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:99:0) after 1m0s
[00:34:11.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:99:0)
[00:34:11.847] Timer tick, asking Buildbucket for the build status
[00:34:12.082] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:12.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:100:0) after 1m0s
[00:35:12.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:100:0)
[00:35:12.128] Timer tick, asking Buildbucket for the build status
[00:35:12.253] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:12.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:101:0) after 1m0s
[00:36:12.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:101:0)
[00:36:12.365] Timer tick, asking Buildbucket for the build status
[00:36:12.574] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:12.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:102:0) after 1m0s
[00:37:12.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:102:0)
[00:37:12.587] Timer tick, asking Buildbucket for the build status
[00:37:12.892] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:12.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:103:0) after 1m0s
[00:38:12.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:103:0)
[00:38:12.986] Timer tick, asking Buildbucket for the build status
[00:38:13.273] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:13.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:104:0) after 1m0s
[00:39:13.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:104:0)
[00:39:13.320] Timer tick, asking Buildbucket for the build status
[00:39:13.528] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:13.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:105:0) after 1m0s
[00:40:13.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:105:0)
[00:40:13.612] Timer tick, asking Buildbucket for the build status
[00:40:14.055] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:14.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:106:0) after 1m0s
[00:41:14.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:106:0)
[00:41:14.133] Timer tick, asking Buildbucket for the build status
[00:41:14.792] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:14.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:107:0) after 1m0s
[00:42:14.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:107:0)
[00:42:14.833] Timer tick, asking Buildbucket for the build status
[00:42:15.012] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:15.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:108:0) after 1m0s
[00:43:15.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:108:0)
[00:43:15.133] Timer tick, asking Buildbucket for the build status
[00:43:15.496] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:15.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:109:0) after 1m0s
[00:44:15.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:109:0)
[00:44:15.520] Timer tick, asking Buildbucket for the build status
[00:44:15.670] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:15.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:110:0) after 1m0s
[00:45:15.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:110:0)
[00:45:15.692] Timer tick, asking Buildbucket for the build status
[00:45:15.995] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:15.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:111:0) after 1m0s
[00:46:16.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:111:0)
[00:46:16.631] Timer tick, asking Buildbucket for the build status
[00:46:16.804] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:16.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:112:0) after 1m0s
[00:47:16.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:112:0)
[00:47:16.864] Timer tick, asking Buildbucket for the build status
[00:47:18.180] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:18.180] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:113:0) after 1m0s
[00:48:18.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:113:0)
[00:48:18.160] Timer tick, asking Buildbucket for the build status
[00:48:18.327] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:18.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:114:0) after 1m0s
[00:49:18.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:114:0)
[00:49:18.461] Timer tick, asking Buildbucket for the build status
[00:49:18.635] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:18.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:115:0) after 1m0s
[00:50:18.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:115:0)
[00:50:18.652] Timer tick, asking Buildbucket for the build status
[00:50:18.781] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:18.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:116:0) after 1m0s
[00:51:18.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:116:0)
[00:51:18.827] Timer tick, asking Buildbucket for the build status
[00:51:19.201] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:19.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:117:0) after 1m0s
[00:52:19.229] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:117:0)
[00:52:19.229] Timer tick, asking Buildbucket for the build status
[00:52:19.320] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:19.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:118:0) after 1m0s
[00:53:19.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:118:0)
[00:53:19.433] Timer tick, asking Buildbucket for the build status
[00:53:19.648] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:19.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:119:0) after 1m0s
[00:54:19.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:119:0)
[00:54:19.678] Timer tick, asking Buildbucket for the build status
[00:54:20.048] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:20.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:120:0) after 1m0s
[00:55:20.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:120:0)
[00:55:20.076] Timer tick, asking Buildbucket for the build status
[00:55:20.183] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:20.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:121:0) after 1m0s
[00:56:20.222] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:121:0)
[00:56:20.222] Timer tick, asking Buildbucket for the build status
[00:56:20.779] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:20.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:122:0) after 1m0s
[00:57:20.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:122:0)
[00:57:20.861] Timer tick, asking Buildbucket for the build status
[00:57:21.091] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:21.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:123:0) after 1m0s
[00:58:21.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:123:0)
[00:58:21.117] Timer tick, asking Buildbucket for the build status
[00:58:21.205] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:21.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:124:0) after 1m0s
[00:59:21.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:124:0)
[00:59:21.277] Timer tick, asking Buildbucket for the build status
[00:59:21.499] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:21.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:125:0) after 1m0s
[01:00:21.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:125:0)
[01:00:21.514] Timer tick, asking Buildbucket for the build status
[01:00:23.110] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:23.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:126:0) after 1m0s
[01:01:23.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:126:0)
[01:01:23.184] Timer tick, asking Buildbucket for the build status
[01:01:23.421] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:23.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:127:0) after 1m0s
[01:02:23.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:127:0)
[01:02:23.514] Timer tick, asking Buildbucket for the build status
[01:02:23.849] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:23.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:128:0) after 1m0s
[01:03:23.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:128:0)
[01:03:23.859] Timer tick, asking Buildbucket for the build status
[01:03:24.024] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:24.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:129:0) after 1m0s
[01:04:24.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:129:0)
[01:04:24.004] Timer tick, asking Buildbucket for the build status
[01:04:24.116] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:24.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:130:0) after 1m0s
[01:05:24.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:130:0)
[01:05:24.216] Timer tick, asking Buildbucket for the build status
[01:05:24.351] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:24.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:131:0) after 1m0s
[01:06:24.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:131:0)
[01:06:24.365] Timer tick, asking Buildbucket for the build status
[01:06:24.624] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:24.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:132:0) after 1m0s
[01:07:24.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:132:0)
[01:07:24.658] Timer tick, asking Buildbucket for the build status
[01:07:24.894] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:24.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:133:0) after 1m0s
[01:08:24.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:133:0)
[01:08:24.947] Timer tick, asking Buildbucket for the build status
[01:08:25.743] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:25.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:134:0) after 1m0s
[01:09:25.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:134:0)
[01:09:25.774] Timer tick, asking Buildbucket for the build status
[01:09:25.958] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:25.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:135:0) after 1m0s
[01:10:26.090] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:135:0)
[01:10:26.090] Timer tick, asking Buildbucket for the build status
[01:10:26.321] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:26.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:136:0) after 1m0s
[01:11:26.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:136:0)
[01:11:26.343] Timer tick, asking Buildbucket for the build status
[01:11:26.723] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:26.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:137:0) after 1m0s
[01:12:26.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:137:0)
[01:12:26.776] Timer tick, asking Buildbucket for the build status
[01:12:26.879] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:26.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:138:0) after 1m0s
[01:13:26.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:138:0)
[01:13:26.934] Timer tick, asking Buildbucket for the build status
[01:13:27.052] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:27.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:139:0) after 1m0s
[01:14:27.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:139:0)
[01:14:27.114] Timer tick, asking Buildbucket for the build status
[01:14:27.229] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:27.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:140:0) after 1m0s
[01:15:27.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:140:0)
[01:15:27.396] Timer tick, asking Buildbucket for the build status
[01:15:27.755] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:27.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:141:0) after 1m0s
[01:16:27.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:141:0)
[01:16:27.805] Timer tick, asking Buildbucket for the build status
[01:16:27.949] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:27.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:142:0) after 1m0s
[01:17:28.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:142:0)
[01:17:28.003] Timer tick, asking Buildbucket for the build status
[01:17:28.104] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:28.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:143:0) after 1m0s
[01:18:28.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:143:0)
[01:18:28.144] Timer tick, asking Buildbucket for the build status
[01:18:28.427] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:28.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:144:0) after 1m0s
[01:19:28.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:144:0)
[01:19:28.499] Timer tick, asking Buildbucket for the build status
[01:19:28.664] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:28.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:145:0) after 1m0s
[01:20:28.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:145:0)
[01:20:28.688] Timer tick, asking Buildbucket for the build status
[01:20:28.760] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:28.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:146:0) after 1m0s
[01:21:28.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:146:0)
[01:21:28.782] Timer tick, asking Buildbucket for the build status
[01:21:30.387] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:30.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:147:0) after 1m0s
[01:22:30.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:147:0)
[01:22:30.448] Timer tick, asking Buildbucket for the build status
[01:22:30.532] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:30.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:148:0) after 1m0s
[01:23:30.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:148:0)
[01:23:30.559] Timer tick, asking Buildbucket for the build status
[01:23:30.723] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:30.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:149:0) after 1m0s
[01:24:30.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:149:0)
[01:24:30.754] Timer tick, asking Buildbucket for the build status
[01:24:30.946] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:30.946] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:150:0) after 1m0s
[01:25:30.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:150:0)
[01:25:30.969] Timer tick, asking Buildbucket for the build status
[01:25:31.489] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:31.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:151:0) after 1m0s
[01:26:31.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:151:0)
[01:26:31.513] Timer tick, asking Buildbucket for the build status
[01:26:31.732] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:31.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:152:0) after 1m0s
[01:27:31.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:152:0)
[01:27:31.749] Timer tick, asking Buildbucket for the build status
[01:27:32.332] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:32.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:153:0) after 1m0s
[01:28:32.360] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:153:0)
[01:28:32.360] Timer tick, asking Buildbucket for the build status
[01:28:32.492] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:32.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:154:0) after 1m0s
[01:29:32.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:154:0)
[01:29:32.540] Timer tick, asking Buildbucket for the build status
[01:29:32.640] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:32.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:155:0) after 1m0s
[01:30:32.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:155:0)
[01:30:32.651] Timer tick, asking Buildbucket for the build status
[01:30:32.904] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:32.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:156:0) after 1m0s
[01:31:32.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:156:0)
[01:31:32.922] Timer tick, asking Buildbucket for the build status
[01:31:33.484] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:33.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:157:0) after 1m0s
[01:32:33.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:157:0)
[01:32:33.512] Timer tick, asking Buildbucket for the build status
[01:32:33.850] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:33.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:158:0) after 1m0s
[01:33:33.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:158:0)
[01:33:33.877] Timer tick, asking Buildbucket for the build status
[01:33:34.333] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:34.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:159:0) after 1m0s
[01:34:34.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:159:0)
[01:34:34.357] Timer tick, asking Buildbucket for the build status
[01:34:34.550] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:34.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:160:0) after 1m0s
[01:35:34.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:160:0)
[01:35:34.593] Timer tick, asking Buildbucket for the build status
[01:35:34.835] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:34.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:161:0) after 1m0s
[01:36:34.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:161:0)
[01:36:34.837] Timer tick, asking Buildbucket for the build status
[01:36:36.269] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:36.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:162:0) after 1m0s
[01:37:36.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:162:0)
[01:37:36.317] Timer tick, asking Buildbucket for the build status
[01:37:36.485] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:36.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:163:0) after 1m0s
[01:38:36.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:163:0)
[01:38:36.605] Timer tick, asking Buildbucket for the build status
[01:38:37.096] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:37.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:164:0) after 1m0s
[01:39:37.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:164:0)
[01:39:37.137] Timer tick, asking Buildbucket for the build status
[01:39:37.366] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:37.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:165:0) after 1m0s
[01:40:37.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:165:0)
[01:40:37.424] Timer tick, asking Buildbucket for the build status
[01:40:37.806] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:37.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:166:0) after 1m0s
[01:41:37.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:166:0)
[01:41:37.837] Timer tick, asking Buildbucket for the build status
[01:41:38.111] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:38.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:167:0) after 1m0s
[01:42:38.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:167:0)
[01:42:38.185] Timer tick, asking Buildbucket for the build status
[01:42:38.479] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:38.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:168:0) after 1m0s
[01:43:38.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:168:0)
[01:43:38.511] Timer tick, asking Buildbucket for the build status
[01:43:38.624] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:38.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:169:0) after 1m0s
[01:44:38.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:169:0)
[01:44:38.744] Timer tick, asking Buildbucket for the build status
[01:44:39.360] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:39.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:170:0) after 1m0s
[01:45:39.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:170:0)
[01:45:39.395] Timer tick, asking Buildbucket for the build status
[01:45:39.501] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:39.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:171:0) after 1m0s
[01:46:39.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:171:0)
[01:46:39.530] Timer tick, asking Buildbucket for the build status
[01:46:40.286] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:40.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:172:0) after 1m0s
[01:47:40.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:172:0)
[01:47:40.284] Timer tick, asking Buildbucket for the build status
[01:47:40.508] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:40.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:173:0) after 1m0s
[01:48:40.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:173:0)
[01:48:40.558] Timer tick, asking Buildbucket for the build status
[01:48:40.742] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:40.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:174:0) after 1m0s
[01:49:40.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:174:0)
[01:49:40.766] Timer tick, asking Buildbucket for the build status
[01:49:40.883] Build 8885449422442679024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:40.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:175:0) after 1m0s
[01:50:14.512] Received PubSub notification, asking Buildbucket for the build status
[01:50:14.854] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:40.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:175:0)
[01:50:40.918] Timer tick, asking Buildbucket for the build status
[01:50:41.547] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:41.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:177:0) after 1m0s
[01:51:41.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:177:0)
[01:51:41.642] Timer tick, asking Buildbucket for the build status
[01:51:42.457] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:42.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:178:0) after 1m0s
[01:52:42.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:178:0)
[01:52:42.477] Timer tick, asking Buildbucket for the build status
[01:52:42.618] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:42.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:179:0) after 1m0s
[01:53:42.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:179:0)
[01:53:42.642] Timer tick, asking Buildbucket for the build status
[01:53:42.756] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:42.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:180:0) after 1m0s
[01:54:42.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:180:0)
[01:54:42.777] Timer tick, asking Buildbucket for the build status
[01:54:42.990] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:42.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:181:0) after 1m0s
[01:55:42.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:181:0)
[01:55:42.977] Timer tick, asking Buildbucket for the build status
[01:55:43.215] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:43.215] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:182:0) after 1m0s
[01:56:43.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:182:0)
[01:56:43.242] Timer tick, asking Buildbucket for the build status
[01:56:43.433] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:43.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:183:0) after 1m0s
[01:57:43.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:183:0)
[01:57:43.530] Timer tick, asking Buildbucket for the build status
[01:57:43.886] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:43.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:184:0) after 1m0s
[01:58:43.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:184:0)
[01:58:43.957] Timer tick, asking Buildbucket for the build status
[01:58:44.146] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:44.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:185:0) after 1m0s
[01:59:44.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:185:0)
[01:59:44.271] Timer tick, asking Buildbucket for the build status
[01:59:44.605] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:44.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:186:0) after 1m0s
[02:00:44.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:186:0)
[02:00:44.647] Timer tick, asking Buildbucket for the build status
[02:00:44.794] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:44.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:187:0) after 1m0s
[02:01:44.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:187:0)
[02:01:44.863] Timer tick, asking Buildbucket for the build status
[02:01:45.423] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:45.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:188:0) after 1m0s
[02:02:45.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:188:0)
[02:02:45.516] Timer tick, asking Buildbucket for the build status
[02:02:45.869] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:45.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:189:0) after 1m0s
[02:03:45.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:189:0)
[02:03:45.946] Timer tick, asking Buildbucket for the build status
[02:03:46.363] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:46.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:190:0) after 1m0s
[02:04:46.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:190:0)
[02:04:46.389] Timer tick, asking Buildbucket for the build status
[02:04:46.515] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:46.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:191:0) after 1m0s
[02:05:46.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:191:0)
[02:05:46.503] Timer tick, asking Buildbucket for the build status
[02:05:46.642] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:46.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:192:0) after 1m0s
[02:06:46.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:192:0)
[02:06:46.694] Timer tick, asking Buildbucket for the build status
[02:06:47.623] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:47.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:193:0) after 1m0s
[02:07:48.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:193:0)
[02:07:48.143] Timer tick, asking Buildbucket for the build status
[02:07:48.204] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:48.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:194:0) after 1m0s
[02:08:48.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:194:0)
[02:08:48.291] Timer tick, asking Buildbucket for the build status
[02:08:48.621] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:48.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:195:0) after 1m0s
[02:09:48.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:195:0)
[02:09:48.780] Timer tick, asking Buildbucket for the build status
[02:09:48.910] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:48.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:196:0) after 1m0s
[02:10:48.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:196:0)
[02:10:48.966] Timer tick, asking Buildbucket for the build status
[02:10:49.044] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:49.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:197:0) after 1m0s
[02:11:49.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:197:0)
[02:11:49.161] Timer tick, asking Buildbucket for the build status
[02:11:49.987] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:49.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:198:0) after 1m0s
[02:12:50.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:198:0)
[02:12:50.413] Timer tick, asking Buildbucket for the build status
[02:12:50.536] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:50.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:199:0) after 1m0s
[02:13:50.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:199:0)
[02:13:50.711] Timer tick, asking Buildbucket for the build status
[02:13:50.831] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:50.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:200:0) after 1m0s
[02:14:51.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:200:0)
[02:14:51.091] Timer tick, asking Buildbucket for the build status
[02:14:51.215] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:51.215] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:201:0) after 1m0s
[02:15:51.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:201:0)
[02:15:51.327] Timer tick, asking Buildbucket for the build status
[02:15:51.508] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:51.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:202:0) after 1m0s
[02:16:51.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:202:0)
[02:16:51.661] Timer tick, asking Buildbucket for the build status
[02:16:51.745] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:51.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:203:0) after 1m0s
[02:17:51.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:203:0)
[02:17:51.931] Timer tick, asking Buildbucket for the build status
[02:17:52.126] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:52.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:204:0) after 1m0s
[02:18:52.260] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:204:0)
[02:18:52.260] Timer tick, asking Buildbucket for the build status
[02:18:52.513] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:52.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:205:0) after 1m0s
[02:19:52.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:205:0)
[02:19:52.527] Timer tick, asking Buildbucket for the build status
[02:19:52.659] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:52.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:206:0) after 1m0s
[02:20:52.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:206:0)
[02:20:52.709] Timer tick, asking Buildbucket for the build status
[02:20:52.814] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:52.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:207:0) after 1m0s
[02:21:52.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:207:0)
[02:21:52.843] Timer tick, asking Buildbucket for the build status
[02:21:53.224] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:53.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:208:0) after 1m0s
[02:22:53.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:208:0)
[02:22:53.377] Timer tick, asking Buildbucket for the build status
[02:22:53.448] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:53.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:209:0) after 1m0s
[02:23:53.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:209:0)
[02:23:53.523] Timer tick, asking Buildbucket for the build status
[02:23:53.671] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:53.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:210:0) after 1m0s
[02:24:53.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:210:0)
[02:24:53.752] Timer tick, asking Buildbucket for the build status
[02:24:53.862] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:53.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:211:0) after 1m0s
[02:25:54.015] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:211:0)
[02:25:54.015] Timer tick, asking Buildbucket for the build status
[02:25:54.092] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:54.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:212:0) after 1m0s
[02:26:54.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:212:0)
[02:26:54.226] Timer tick, asking Buildbucket for the build status
[02:26:54.415] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:54.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:213:0) after 1m0s
[02:27:54.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:213:0)
[02:27:54.485] Timer tick, asking Buildbucket for the build status
[02:27:54.638] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:54.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:214:0) after 1m0s
[02:28:54.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:214:0)
[02:28:54.746] Timer tick, asking Buildbucket for the build status
[02:28:54.807] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:54.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:215:0) after 1m0s
[02:29:54.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:215:0)
[02:29:54.872] Timer tick, asking Buildbucket for the build status
[02:29:55.201] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:55.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:216:0) after 1m0s
[02:30:55.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:216:0)
[02:30:55.392] Timer tick, asking Buildbucket for the build status
[02:30:55.676] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:55.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:217:0) after 1m0s
[02:31:55.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:217:0)
[02:31:55.786] Timer tick, asking Buildbucket for the build status
[02:31:55.870] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:55.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:218:0) after 1m0s
[02:32:55.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:218:0)
[02:32:55.964] Timer tick, asking Buildbucket for the build status
[02:32:56.185] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:56.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:219:0) after 1m0s
[02:33:56.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:219:0)
[02:33:56.318] Timer tick, asking Buildbucket for the build status
[02:33:56.738] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:56.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:220:0) after 1m0s
[02:34:56.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:220:0)
[02:34:56.728] Timer tick, asking Buildbucket for the build status
[02:34:56.871] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:56.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:221:0) after 1m0s
[02:35:56.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:221:0)
[02:35:56.914] Timer tick, asking Buildbucket for the build status
[02:35:57.648] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:57.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:222:0) after 1m0s
[02:36:57.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:222:0)
[02:36:57.743] Timer tick, asking Buildbucket for the build status
[02:36:58.004] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:58.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:223:0) after 1m0s
[02:37:58.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:223:0)
[02:37:58.118] Timer tick, asking Buildbucket for the build status
[02:37:58.282] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:58.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:224:0) after 1m0s
[02:38:58.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:224:0)
[02:38:58.400] Timer tick, asking Buildbucket for the build status
[02:38:58.508] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:58.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:225:0) after 1m0s
[02:39:58.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:225:0)
[02:39:58.715] Timer tick, asking Buildbucket for the build status
[02:39:59.105] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:59.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:226:0) after 1m0s
[02:40:59.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:226:0)
[02:40:59.233] Timer tick, asking Buildbucket for the build status
[02:40:59.408] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:59.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:227:0) after 1m0s
[02:41:59.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:227:0)
[02:41:59.493] Timer tick, asking Buildbucket for the build status
[02:41:59.571] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:59.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:228:0) after 1m0s
[02:42:59.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:228:0)
[02:42:59.716] Timer tick, asking Buildbucket for the build status
[02:43:00.470] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:00.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:229:0) after 1m0s
[02:44:00.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:229:0)
[02:44:00.705] Timer tick, asking Buildbucket for the build status
[02:44:00.915] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:00.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:230:0) after 1m0s
[02:45:01.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:230:0)
[02:45:01.003] Timer tick, asking Buildbucket for the build status
[02:45:01.151] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:01.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:231:0) after 1m0s
[02:46:01.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:231:0)
[02:46:01.184] Timer tick, asking Buildbucket for the build status
[02:46:01.349] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:01.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:232:0) after 1m0s
[02:47:01.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:232:0)
[02:47:01.431] Timer tick, asking Buildbucket for the build status
[02:47:01.661] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:01.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:233:0) after 1m0s
[02:48:01.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:233:0)
[02:48:01.730] Timer tick, asking Buildbucket for the build status
[02:48:01.869] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:01.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:234:0) after 1m0s
[02:49:02.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:234:0)
[02:49:02.084] Timer tick, asking Buildbucket for the build status
[02:49:02.410] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:02.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:235:0) after 1m0s
[02:50:02.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:235:0)
[02:50:02.437] Timer tick, asking Buildbucket for the build status
[02:50:02.590] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:02.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:236:0) after 1m0s
[02:51:02.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:236:0)
[02:51:02.600] Timer tick, asking Buildbucket for the build status
[02:51:02.729] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:02.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:237:0) after 1m0s
[02:52:02.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:237:0)
[02:52:02.829] Timer tick, asking Buildbucket for the build status
[02:52:02.934] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:02.934] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:238:0) after 1m0s
[02:53:02.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:238:0)
[02:53:02.959] Timer tick, asking Buildbucket for the build status
[02:53:03.328] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:03.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:239:0) after 1m0s
[02:54:03.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:239:0)
[02:54:03.372] Timer tick, asking Buildbucket for the build status
[02:54:03.522] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:03.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:240:0) after 1m0s
[02:55:03.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:240:0)
[02:55:03.601] Timer tick, asking Buildbucket for the build status
[02:55:03.800] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:03.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:241:0) after 1m0s
[02:56:03.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:241:0)
[02:56:03.861] Timer tick, asking Buildbucket for the build status
[02:56:04.408] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:04.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:242:0) after 1m0s
[02:57:04.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:242:0)
[02:57:04.563] Timer tick, asking Buildbucket for the build status
[02:57:04.723] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:04.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:243:0) after 1m0s
[02:58:04.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:243:0)
[02:58:04.834] Timer tick, asking Buildbucket for the build status
[02:58:04.903] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:04.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:244:0) after 1m0s
[02:59:04.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:244:0)
[02:59:04.922] Timer tick, asking Buildbucket for the build status
[02:59:05.128] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:05.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:245:0) after 1m0s
[03:00:05.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:245:0)
[03:00:05.142] Timer tick, asking Buildbucket for the build status
[03:00:05.335] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:05.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:246:0) after 1m0s
[03:01:05.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:246:0)
[03:01:05.363] Timer tick, asking Buildbucket for the build status
[03:01:05.719] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:05.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:247:0) after 1m0s
[03:02:05.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:247:0)
[03:02:05.756] Timer tick, asking Buildbucket for the build status
[03:02:05.863] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:05.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:248:0) after 1m0s
[03:03:05.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:248:0)
[03:03:05.903] Timer tick, asking Buildbucket for the build status
[03:03:06.125] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:06.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:249:0) after 1m0s
[03:04:06.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:249:0)
[03:04:06.172] Timer tick, asking Buildbucket for the build status
[03:04:06.423] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:06.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:250:0) after 1m0s
[03:05:06.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:250:0)
[03:05:06.453] Timer tick, asking Buildbucket for the build status
[03:05:06.585] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:06.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:251:0) after 1m0s
[03:06:06.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:251:0)
[03:06:06.669] Timer tick, asking Buildbucket for the build status
[03:06:06.919] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:06.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:252:0) after 1m0s
[03:07:06.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:252:0)
[03:07:06.951] Timer tick, asking Buildbucket for the build status
[03:07:07.352] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:07.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:253:0) after 1m0s
[03:08:07.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:253:0)
[03:08:07.460] Timer tick, asking Buildbucket for the build status
[03:08:07.584] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:07.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:254:0) after 1m0s
[03:09:07.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:254:0)
[03:09:07.743] Timer tick, asking Buildbucket for the build status
[03:09:07.971] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:07.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:255:0) after 1m0s
[03:10:08.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:255:0)
[03:10:08.142] Timer tick, asking Buildbucket for the build status
[03:10:08.327] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:08.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:256:0) after 1m0s
[03:11:08.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:256:0)
[03:11:08.825] Timer tick, asking Buildbucket for the build status
[03:11:08.995] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:08.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:257:0) after 1m0s
[03:12:09.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:257:0)
[03:12:09.216] Timer tick, asking Buildbucket for the build status
[03:12:09.425] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:09.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:258:0) after 1m0s
[03:13:09.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:258:0)
[03:13:09.452] Timer tick, asking Buildbucket for the build status
[03:13:09.602] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:09.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:259:0) after 1m0s
[03:14:09.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:259:0)
[03:14:09.646] Timer tick, asking Buildbucket for the build status
[03:14:09.779] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:09.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:260:0) after 1m0s
[03:15:09.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:260:0)
[03:15:09.920] Timer tick, asking Buildbucket for the build status
[03:15:10.341] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:10.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:261:0) after 1m0s
[03:16:10.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:261:0)
[03:16:10.448] Timer tick, asking Buildbucket for the build status
[03:16:10.811] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:10.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:262:0) after 1m0s
[03:17:10.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:262:0)
[03:17:10.938] Timer tick, asking Buildbucket for the build status
[03:17:11.198] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:11.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:263:0) after 1m0s
[03:18:11.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:263:0)
[03:18:11.230] Timer tick, asking Buildbucket for the build status
[03:18:11.335] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:11.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:264:0) after 1m0s
[03:19:11.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:264:0)
[03:19:11.679] Timer tick, asking Buildbucket for the build status
[03:19:12.045] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:12.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:265:0) after 1m0s
[03:20:12.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:265:0)
[03:20:12.192] Timer tick, asking Buildbucket for the build status
[03:20:12.304] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:12.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:266:0) after 1m0s
[03:21:12.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:266:0)
[03:21:12.595] Timer tick, asking Buildbucket for the build status
[03:21:13.042] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:13.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:267:0) after 1m0s
[03:22:13.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:267:0)
[03:22:13.061] Timer tick, asking Buildbucket for the build status
[03:22:13.222] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:13.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:268:0) after 1m0s
[03:23:13.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:268:0)
[03:23:13.275] Timer tick, asking Buildbucket for the build status
[03:23:13.510] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:13.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:269:0) after 1m0s
[03:24:13.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:269:0)
[03:24:13.585] Timer tick, asking Buildbucket for the build status
[03:24:13.645] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:13.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:270:0) after 1m0s
[03:25:13.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:270:0)
[03:25:13.858] Timer tick, asking Buildbucket for the build status
[03:25:15.014] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:15.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:271:0) after 1m0s
[03:26:15.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:271:0)
[03:26:15.214] Timer tick, asking Buildbucket for the build status
[03:26:15.451] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:15.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:272:0) after 1m0s
[03:27:15.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:272:0)
[03:27:15.505] Timer tick, asking Buildbucket for the build status
[03:27:15.654] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:15.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:273:0) after 1m0s
[03:28:15.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:273:0)
[03:28:15.714] Timer tick, asking Buildbucket for the build status
[03:28:15.895] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:15.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:274:0) after 1m0s
[03:29:15.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:274:0)
[03:29:15.971] Timer tick, asking Buildbucket for the build status
[03:29:16.319] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:16.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:275:0) after 1m0s
[03:30:16.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:275:0)
[03:30:16.363] Timer tick, asking Buildbucket for the build status
[03:30:16.759] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:16.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:276:0) after 1m0s
[03:31:16.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:276:0)
[03:31:16.818] Timer tick, asking Buildbucket for the build status
[03:31:17.084] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:17.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:277:0) after 1m0s
[03:32:17.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:277:0)
[03:32:17.215] Timer tick, asking Buildbucket for the build status
[03:32:17.600] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:17.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:278:0) after 1m0s
[03:33:17.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:278:0)
[03:33:17.667] Timer tick, asking Buildbucket for the build status
[03:33:17.944] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:17.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:279:0) after 1m0s
[03:34:18.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:279:0)
[03:34:18.067] Timer tick, asking Buildbucket for the build status
[03:34:18.186] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:18.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:280:0) after 1m0s
[03:35:18.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:280:0)
[03:35:18.256] Timer tick, asking Buildbucket for the build status
[03:35:18.358] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:18.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:281:0) after 1m0s
[03:36:18.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:281:0)
[03:36:18.465] Timer tick, asking Buildbucket for the build status
[03:36:18.972] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:18.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:282:0) after 1m0s
[03:37:19.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:282:0)
[03:37:19.103] Timer tick, asking Buildbucket for the build status
[03:37:19.214] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:19.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:283:0) after 1m0s
[03:38:19.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:283:0)
[03:38:19.408] Timer tick, asking Buildbucket for the build status
[03:38:19.523] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:19.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:284:0) after 1m0s
[03:39:19.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:284:0)
[03:39:19.595] Timer tick, asking Buildbucket for the build status
[03:39:20.138] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:20.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:285:0) after 1m0s
[03:40:20.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:285:0)
[03:40:20.304] Timer tick, asking Buildbucket for the build status
[03:40:20.542] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:20.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:286:0) after 1m0s
[03:41:20.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:286:0)
[03:41:20.721] Timer tick, asking Buildbucket for the build status
[03:41:20.981] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:20.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:287:0) after 1m0s
[03:42:21.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:287:0)
[03:42:21.002] Timer tick, asking Buildbucket for the build status
[03:42:21.096] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:21.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:288:0) after 1m0s
[03:43:21.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:288:0)
[03:43:21.175] Timer tick, asking Buildbucket for the build status
[03:43:21.583] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:21.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:289:0) after 1m0s
[03:44:21.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:289:0)
[03:44:21.624] Timer tick, asking Buildbucket for the build status
[03:44:22.068] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:22.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:290:0) after 1m0s
[03:45:22.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:290:0)
[03:45:22.099] Timer tick, asking Buildbucket for the build status
[03:45:22.209] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:22.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:291:0) after 1m0s
[03:46:22.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:291:0)
[03:46:22.272] Timer tick, asking Buildbucket for the build status
[03:46:22.831] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:22.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:292:0) after 1m0s
[03:47:22.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:292:0)
[03:47:22.906] Timer tick, asking Buildbucket for the build status
[03:47:23.023] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:23.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:293:0) after 1m0s
[03:48:23.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:293:0)
[03:48:23.119] Timer tick, asking Buildbucket for the build status
[03:48:23.478] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:23.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:294:0) after 1m0s
[03:49:23.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:294:0)
[03:49:23.503] Timer tick, asking Buildbucket for the build status
[03:49:23.626] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:23.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:295:0) after 1m0s
[03:50:23.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:295:0)
[03:50:23.692] Timer tick, asking Buildbucket for the build status
[03:50:24.022] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:24.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:296:0) after 1m0s
[03:51:24.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:296:0)
[03:51:24.033] Timer tick, asking Buildbucket for the build status
[03:51:24.788] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:24.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:297:0) after 1m0s
[03:52:24.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:297:0)
[03:52:24.821] Timer tick, asking Buildbucket for the build status
[03:52:24.949] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:24.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:298:0) after 1m0s
[03:53:24.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:298:0)
[03:53:24.991] Timer tick, asking Buildbucket for the build status
[03:53:25.082] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:25.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:299:0) after 1m0s
[03:54:25.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:299:0)
[03:54:25.128] Timer tick, asking Buildbucket for the build status
[03:54:25.246] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:25.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:300:0) after 1m0s
[03:55:25.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:300:0)
[03:55:25.309] Timer tick, asking Buildbucket for the build status
[03:55:25.441] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:25.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:301:0) after 1m0s
[03:56:25.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:301:0)
[03:56:25.525] Timer tick, asking Buildbucket for the build status
[03:56:25.814] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:25.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:302:0) after 1m0s
[03:57:25.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:302:0)
[03:57:25.877] Timer tick, asking Buildbucket for the build status
[03:57:26.014] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:26.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:303:0) after 1m0s
[03:58:26.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:303:0)
[03:58:26.041] Timer tick, asking Buildbucket for the build status
[03:58:27.081] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:27.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:304:0) after 1m0s
[03:59:27.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:304:0)
[03:59:27.138] Timer tick, asking Buildbucket for the build status
[03:59:28.033] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:28.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:305:0) after 1m0s
[04:00:28.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:305:0)
[04:00:28.161] Timer tick, asking Buildbucket for the build status
[04:00:28.374] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:28.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:306:0) after 1m0s
[04:01:28.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:306:0)
[04:01:28.418] Timer tick, asking Buildbucket for the build status
[04:01:30.478] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:30.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:307:0) after 1m0s
[04:02:30.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:307:0)
[04:02:30.538] Timer tick, asking Buildbucket for the build status
[04:02:31.372] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:31.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:308:0) after 1m0s
[04:03:31.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:308:0)
[04:03:31.401] Timer tick, asking Buildbucket for the build status
[04:03:31.653] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:31.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:309:0) after 1m0s
[04:04:31.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:309:0)
[04:04:31.669] Timer tick, asking Buildbucket for the build status
[04:04:31.918] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:31.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:310:0) after 1m0s
[04:05:31.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:310:0)
[04:05:31.950] Timer tick, asking Buildbucket for the build status
[04:05:32.109] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:32.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:311:0) after 1m0s
[04:06:32.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:311:0)
[04:06:32.135] Timer tick, asking Buildbucket for the build status
[04:06:32.370] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:32.370] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:312:0) after 1m0s
[04:07:32.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:312:0)
[04:07:32.465] Timer tick, asking Buildbucket for the build status
[04:07:32.630] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:32.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:313:0) after 1m0s
[04:08:32.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:313:0)
[04:08:32.672] Timer tick, asking Buildbucket for the build status
[04:08:32.732] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:32.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:314:0) after 1m0s
[04:09:32.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:314:0)
[04:09:32.759] Timer tick, asking Buildbucket for the build status
[04:09:32.879] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:32.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:315:0) after 1m0s
[04:10:32.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:315:0)
[04:10:32.906] Timer tick, asking Buildbucket for the build status
[04:10:33.259] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:33.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:316:0) after 1m0s
[04:11:33.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:316:0)
[04:11:33.309] Timer tick, asking Buildbucket for the build status
[04:11:33.643] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:33.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:317:0) after 1m0s
[04:12:33.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:317:0)
[04:12:33.677] Timer tick, asking Buildbucket for the build status
[04:12:33.779] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:33.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:318:0) after 1m0s
[04:13:33.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:318:0)
[04:13:33.846] Timer tick, asking Buildbucket for the build status
[04:13:34.190] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:34.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:319:0) after 1m0s
[04:14:34.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:319:0)
[04:14:34.221] Timer tick, asking Buildbucket for the build status
[04:14:34.350] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:34.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:320:0) after 1m0s
[04:15:34.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:320:0)
[04:15:34.380] Timer tick, asking Buildbucket for the build status
[04:15:34.528] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:34.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:321:0) after 1m0s
[04:16:34.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:321:0)
[04:16:34.592] Timer tick, asking Buildbucket for the build status
[04:16:35.218] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:35.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:322:0) after 1m0s
[04:17:35.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:322:0)
[04:17:35.242] Timer tick, asking Buildbucket for the build status
[04:17:36.843] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:36.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:323:0) after 1m0s
[04:18:36.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:323:0)
[04:18:36.872] Timer tick, asking Buildbucket for the build status
[04:18:37.046] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:37.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:324:0) after 1m0s
[04:19:37.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:324:0)
[04:19:37.203] Timer tick, asking Buildbucket for the build status
[04:19:37.859] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:37.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:325:0) after 1m0s
[04:20:37.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:325:0)
[04:20:37.935] Timer tick, asking Buildbucket for the build status
[04:20:38.115] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:38.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:326:0) after 1m0s
[04:21:38.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:326:0)
[04:21:38.164] Timer tick, asking Buildbucket for the build status
[04:21:38.663] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:38.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:327:0) after 1m0s
[04:22:38.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:327:0)
[04:22:38.698] Timer tick, asking Buildbucket for the build status
[04:22:38.922] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:38.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:328:0) after 1m0s
[04:23:38.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:328:0)
[04:23:38.961] Timer tick, asking Buildbucket for the build status
[04:23:39.149] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:39.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:329:0) after 1m0s
[04:24:39.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:329:0)
[04:24:39.185] Timer tick, asking Buildbucket for the build status
[04:24:39.404] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:39.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:330:0) after 1m0s
[04:25:39.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:330:0)
[04:25:39.480] Timer tick, asking Buildbucket for the build status
[04:25:39.588] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:39.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:331:0) after 1m0s
[04:26:39.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:331:0)
[04:26:39.637] Timer tick, asking Buildbucket for the build status
[04:26:42.062] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:42.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:332:0) after 1m0s
[04:27:42.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:332:0)
[04:27:42.177] Timer tick, asking Buildbucket for the build status
[04:27:42.617] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:42.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:333:0) after 1m0s
[04:28:42.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:333:0)
[04:28:42.743] Timer tick, asking Buildbucket for the build status
[04:28:43.525] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:43.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:334:0) after 1m0s
[04:29:43.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:334:0)
[04:29:43.618] Timer tick, asking Buildbucket for the build status
[04:29:43.716] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:43.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:335:0) after 1m0s
[04:30:43.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:335:0)
[04:30:43.747] Timer tick, asking Buildbucket for the build status
[04:30:43.904] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:43.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:336:0) after 1m0s
[04:31:43.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:336:0)
[04:31:43.985] Timer tick, asking Buildbucket for the build status
[04:31:45.198] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:45.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:337:0) after 1m0s
[04:32:45.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:337:0)
[04:32:45.232] Timer tick, asking Buildbucket for the build status
[04:32:45.375] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:45.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:338:0) after 1m0s
[04:33:45.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:338:0)
[04:33:45.516] Timer tick, asking Buildbucket for the build status
[04:33:45.665] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:45.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:339:0) after 1m0s
[04:34:45.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:339:0)
[04:34:45.720] Timer tick, asking Buildbucket for the build status
[04:34:46.236] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:46.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:340:0) after 1m0s
[04:35:46.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:340:0)
[04:35:46.367] Timer tick, asking Buildbucket for the build status
[04:35:46.662] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:46.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:341:0) after 1m0s
[04:36:46.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:341:0)
[04:36:46.770] Timer tick, asking Buildbucket for the build status
[04:36:51.112] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:51.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:342:0) after 1m0s
[04:37:51.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:342:0)
[04:37:51.383] Timer tick, asking Buildbucket for the build status
[04:37:51.809] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:51.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:343:0) after 1m0s
[04:38:51.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:343:0)
[04:38:51.835] Timer tick, asking Buildbucket for the build status
[04:38:51.960] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:51.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:344:0) after 1m0s
[04:39:52.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:344:0)
[04:39:52.092] Timer tick, asking Buildbucket for the build status
[04:39:52.486] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:52.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:345:0) after 1m0s
[04:40:52.524] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:345:0)
[04:40:52.524] Timer tick, asking Buildbucket for the build status
[04:40:52.798] Build 8885449422442679024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:52.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050879484908233168:346:0) after 1m0s
[04:41:03.804] Received PubSub notification, asking Buildbucket for the build status
[04:41:04.227] Build 8885449422442679024: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:41:04.227] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1584592862935379",
"created_by": "project:infra",
"created_ts": "1584572118297250",
"id": "8885449422442679024",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"82.0.4085.12\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"92c0b2f5-b6ec-4c69-8712-5474fe30f7af\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"82.0.4085.12\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"82.0.4085.12\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"92c0b2f5-b6ec-4c69-8712-5474fe30f7af\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-v5lg\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"82.0.4085.12\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"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-v5lg\"], \"image\": [\"chrome-xenial-20031500-6b26172a85c\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4874-3598771\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1584582612571622",
"status": "COMPLETED",
"status_changed_ts": "1584592863328245",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9050879484908233168",
"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/8885449422442679024/+/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:4b08ae04897de610",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1584592863344816",
"url": "https://ci.chromium.org/b/8885449422442679024",
"utcnow_ts": "1584592864168358"
}
}
[04:41:04.227] Invocation finished in 5h45m47.665452782s with status SUCCEEDED