[23:12:25.013] New invocation is queued and will start shortly
[23:12:25.013] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[23:12:26.176] Starting the invocation (attempt 1)
[23:12:26.212] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:12:26.212] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:12:26.212] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9048160497523902496",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"84.0.4117.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"ad13e1c7-1efc-4a25-9ff9-cbe6489e6809\",\"title\":\"publish_tarball/0\"}]},\"version\":\"84.0.4117.2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9048160497523902496",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[23:12:26.924] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:infra",
"created_ts": "1587165146341829",
"id": "8882730435468110688",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4117.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ad13e1c7-1efc-4a25-9ff9-cbe6489e6809\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4117.2\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1587165146650034",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9048160497523902496",
"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/8882730435468110688/+/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": "1587165146653751",
"url": "https://ci.chromium.org/b/8882730435468110688",
"utcnow_ts": "1587165146908434"
}
}
[23:12:26.924] Task URL: https://ci.chromium.org/b/8882730435468110688
[23:12:26.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:2:0) after 1m0s
[23:13:26.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:2:0)
[23:13:26.975] Timer tick, asking Buildbucket for the build status
[23:13:27.157] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:27.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:3:0) after 1m0s
[23:14:27.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:3:0)
[23:14:27.293] Timer tick, asking Buildbucket for the build status
[23:14:27.445] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:27.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:4:0) after 1m0s
[23:15:27.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:4:0)
[23:15:27.463] Timer tick, asking Buildbucket for the build status
[23:15:27.712] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:27.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:5:0) after 1m0s
[23:16:27.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:5:0)
[23:16:27.738] Timer tick, asking Buildbucket for the build status
[23:16:27.863] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:27.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:6:0) after 1m0s
[23:17:28.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:6:0)
[23:17:28.107] Timer tick, asking Buildbucket for the build status
[23:17:28.771] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:28.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:7:0) after 1m0s
[23:18:28.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:7:0)
[23:18:28.857] Timer tick, asking Buildbucket for the build status
[23:18:29.010] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:29.010] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:8:0) after 1m0s
[23:19:29.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:8:0)
[23:19:29.088] Timer tick, asking Buildbucket for the build status
[23:19:29.589] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:29.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:9:0) after 1m0s
[23:20:29.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:9:0)
[23:20:29.765] Timer tick, asking Buildbucket for the build status
[23:20:29.956] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:29.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:10:0) after 1m0s
[23:21:30.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:10:0)
[23:21:30.107] Timer tick, asking Buildbucket for the build status
[23:21:30.351] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:30.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:11:0) after 1m0s
[23:22:30.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:11:0)
[23:22:30.442] Timer tick, asking Buildbucket for the build status
[23:22:30.604] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:30.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:12:0) after 1m0s
[23:23:30.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:12:0)
[23:23:30.631] Timer tick, asking Buildbucket for the build status
[23:23:30.799] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:30.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:13:0) after 1m0s
[23:24:30.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:13:0)
[23:24:30.897] Timer tick, asking Buildbucket for the build status
[23:24:31.056] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:31.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:14:0) after 1m0s
[23:25:31.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:14:0)
[23:25:31.237] Timer tick, asking Buildbucket for the build status
[23:25:31.372] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:31.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:15:0) after 1m0s
[23:26:31.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:15:0)
[23:26:31.486] Timer tick, asking Buildbucket for the build status
[23:26:31.744] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:31.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:16:0) after 1m0s
[23:27:31.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:16:0)
[23:27:31.833] Timer tick, asking Buildbucket for the build status
[23:27:31.953] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:31.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:17:0) after 1m0s
[23:28:32.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:17:0)
[23:28:32.126] Timer tick, asking Buildbucket for the build status
[23:28:32.581] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:32.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:18:0) after 1m0s
[23:29:32.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:18:0)
[23:29:32.696] Timer tick, asking Buildbucket for the build status
[23:29:32.821] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:32.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:19:0) after 1m0s
[23:30:32.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:19:0)
[23:30:32.932] Timer tick, asking Buildbucket for the build status
[23:30:33.102] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:33.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:20:0) after 1m0s
[23:31:33.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:20:0)
[23:31:33.223] Timer tick, asking Buildbucket for the build status
[23:31:33.415] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:33.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:21:0) after 1m0s
[23:32:33.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:21:0)
[23:32:33.593] Timer tick, asking Buildbucket for the build status
[23:32:33.845] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:33.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:22:0) after 1m0s
[23:33:33.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:22:0)
[23:33:33.956] Timer tick, asking Buildbucket for the build status
[23:33:34.688] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:34.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:23:0) after 1m0s
[23:34:34.926] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:23:0)
[23:34:34.926] Timer tick, asking Buildbucket for the build status
[23:34:35.755] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:35.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:24:0) after 1m0s
[23:35:35.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:24:0)
[23:35:35.779] Timer tick, asking Buildbucket for the build status
[23:35:35.995] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:35.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:25:0) after 1m0s
[23:36:35.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:25:0)
[23:36:35.971] Timer tick, asking Buildbucket for the build status
[23:36:36.623] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:36.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:26:0) after 1m0s
[23:37:36.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:26:0)
[23:37:36.649] Timer tick, asking Buildbucket for the build status
[23:37:37.092] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:37.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:27:0) after 1m0s
[23:38:37.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:27:0)
[23:38:37.175] Timer tick, asking Buildbucket for the build status
[23:38:37.355] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:37.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:28:0) after 1m0s
[23:39:37.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:28:0)
[23:39:37.377] Timer tick, asking Buildbucket for the build status
[23:39:37.747] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:37.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:29:0) after 1m0s
[23:40:37.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:29:0)
[23:40:37.794] Timer tick, asking Buildbucket for the build status
[23:40:38.004] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:38.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:30:0) after 1m0s
[23:41:38.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:30:0)
[23:41:38.095] Timer tick, asking Buildbucket for the build status
[23:41:38.409] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:38.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:31:0) after 1m0s
[23:42:38.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:31:0)
[23:42:38.511] Timer tick, asking Buildbucket for the build status
[23:42:38.743] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:38.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:32:0) after 1m0s
[23:43:38.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:32:0)
[23:43:38.810] Timer tick, asking Buildbucket for the build status
[23:43:38.984] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:38.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:33:0) after 1m0s
[23:44:39.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:33:0)
[23:44:39.088] Timer tick, asking Buildbucket for the build status
[23:44:39.588] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:39.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:34:0) after 1m0s
[23:45:39.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:34:0)
[23:45:39.843] Timer tick, asking Buildbucket for the build status
[23:45:41.439] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:41.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:35:0) after 1m0s
[23:46:41.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:35:0)
[23:46:41.522] Timer tick, asking Buildbucket for the build status
[23:46:42.214] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:42.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:36:0) after 1m0s
[23:47:42.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:36:0)
[23:47:42.459] Timer tick, asking Buildbucket for the build status
[23:47:43.402] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:43.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:37:0) after 1m0s
[23:48:43.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:37:0)
[23:48:43.429] Timer tick, asking Buildbucket for the build status
[23:48:43.861] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:43.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:38:0) after 1m0s
[23:49:43.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:38:0)
[23:49:43.900] Timer tick, asking Buildbucket for the build status
[23:49:44.433] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:44.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:39:0) after 1m0s
[23:50:44.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:39:0)
[23:50:44.445] Timer tick, asking Buildbucket for the build status
[23:50:46.164] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:46.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:40:0) after 1m0s
[23:51:46.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:40:0)
[23:51:46.185] Timer tick, asking Buildbucket for the build status
[23:51:46.391] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:46.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:41:0) after 1m0s
[23:52:46.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:41:0)
[23:52:46.445] Timer tick, asking Buildbucket for the build status
[23:52:46.589] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:46.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:42:0) after 1m0s
[23:53:46.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:42:0)
[23:53:46.613] Timer tick, asking Buildbucket for the build status
[23:53:46.988] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:46.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:43:0) after 1m0s
[23:54:47.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:43:0)
[23:54:47.008] Timer tick, asking Buildbucket for the build status
[23:54:49.789] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:49.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:44:0) after 1m0s
[23:55:49.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:44:0)
[23:55:49.818] Timer tick, asking Buildbucket for the build status
[23:55:49.994] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:49.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:45:0) after 1m0s
[23:56:50.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:45:0)
[23:56:50.033] Timer tick, asking Buildbucket for the build status
[23:56:50.137] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:50.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:46:0) after 1m0s
[23:57:50.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:46:0)
[23:57:50.164] Timer tick, asking Buildbucket for the build status
[23:57:50.300] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:50.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:47:0) after 1m0s
[23:58:50.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:47:0)
[23:58:50.388] Timer tick, asking Buildbucket for the build status
[23:58:50.475] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:50.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:48:0) after 1m0s
[23:59:50.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:48:0)
[23:59:50.462] Timer tick, asking Buildbucket for the build status
[23:59:52.996] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:52.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:49:0) after 1m0s
[00:00:53.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:49:0)
[00:00:53.096] Timer tick, asking Buildbucket for the build status
[00:00:53.362] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:53.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:50:0) after 1m0s
[00:01:53.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:50:0)
[00:01:53.386] Timer tick, asking Buildbucket for the build status
[00:01:53.910] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:53.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:51:0) after 1m0s
[00:02:54.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:51:0)
[00:02:54.046] Timer tick, asking Buildbucket for the build status
[00:02:54.293] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:54.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:52:0) after 1m0s
[00:03:54.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:52:0)
[00:03:54.387] Timer tick, asking Buildbucket for the build status
[00:03:54.600] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:54.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:53:0) after 1m0s
[00:04:54.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:53:0)
[00:04:54.626] Timer tick, asking Buildbucket for the build status
[00:04:55.084] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:55.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:54:0) after 1m0s
[00:05:55.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:54:0)
[00:05:55.154] Timer tick, asking Buildbucket for the build status
[00:05:55.308] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:55.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:55:0) after 1m0s
[00:06:55.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:55:0)
[00:06:55.348] Timer tick, asking Buildbucket for the build status
[00:06:55.677] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:55.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:56:0) after 1m0s
[00:07:55.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:56:0)
[00:07:55.773] Timer tick, asking Buildbucket for the build status
[00:07:55.917] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:55.917] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:57:0) after 1m0s
[00:08:56.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:57:0)
[00:08:56.157] Timer tick, asking Buildbucket for the build status
[00:08:56.293] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:56.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:58:0) after 1m0s
[00:09:56.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:58:0)
[00:09:56.467] Timer tick, asking Buildbucket for the build status
[00:09:56.978] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:56.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:59:0) after 1m0s
[00:10:57.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:59:0)
[00:10:57.088] Timer tick, asking Buildbucket for the build status
[00:10:57.207] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:57.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:60:0) after 1m0s
[00:11:57.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:60:0)
[00:11:57.372] Timer tick, asking Buildbucket for the build status
[00:11:57.735] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:57.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:61:0) after 1m0s
[00:12:57.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:61:0)
[00:12:57.782] Timer tick, asking Buildbucket for the build status
[00:12:57.982] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:57.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:62:0) after 1m0s
[00:13:58.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:62:0)
[00:13:58.095] Timer tick, asking Buildbucket for the build status
[00:13:58.312] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:58.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:63:0) after 1m0s
[00:14:58.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:63:0)
[00:14:58.386] Timer tick, asking Buildbucket for the build status
[00:14:58.538] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:58.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:64:0) after 1m0s
[00:16:00.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:64:0)
[00:16:00.007] Timer tick, asking Buildbucket for the build status
[00:16:00.150] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:00.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:65:0) after 1m0s
[00:17:00.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:65:0)
[00:17:00.641] Timer tick, asking Buildbucket for the build status
[00:17:00.794] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:00.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:66:0) after 1m0s
[00:18:01.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:66:0)
[00:18:01.570] Timer tick, asking Buildbucket for the build status
[00:18:02.704] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:02.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:67:0) after 1m0s
[00:19:03.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:67:0)
[00:19:03.328] Timer tick, asking Buildbucket for the build status
[00:19:03.573] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:03.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:68:0) after 1m0s
[00:20:03.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:68:0)
[00:20:03.806] Timer tick, asking Buildbucket for the build status
[00:20:04.576] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:04.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:69:0) after 1m0s
[00:21:04.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:69:0)
[00:21:04.726] Timer tick, asking Buildbucket for the build status
[00:21:05.488] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:05.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:70:0) after 1m0s
[00:22:06.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:70:0)
[00:22:06.184] Timer tick, asking Buildbucket for the build status
[00:22:07.714] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:07.714] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:71:0) after 1m0s
[00:23:07.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:71:0)
[00:23:07.746] Timer tick, asking Buildbucket for the build status
[00:23:07.910] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:07.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:72:0) after 1m0s
[00:24:07.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:72:0)
[00:24:07.932] Timer tick, asking Buildbucket for the build status
[00:24:08.453] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:08.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:73:0) after 1m0s
[00:25:08.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:73:0)
[00:25:08.492] Timer tick, asking Buildbucket for the build status
[00:25:08.764] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:08.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:74:0) after 1m0s
[00:26:08.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:74:0)
[00:26:08.831] Timer tick, asking Buildbucket for the build status
[00:26:08.983] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:08.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:75:0) after 1m0s
[00:27:09.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:75:0)
[00:27:09.041] Timer tick, asking Buildbucket for the build status
[00:27:09.385] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:09.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:76:0) after 1m0s
[00:28:09.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:76:0)
[00:28:09.422] Timer tick, asking Buildbucket for the build status
[00:28:10.000] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:10.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:77:0) after 1m0s
[00:29:10.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:77:0)
[00:29:10.083] Timer tick, asking Buildbucket for the build status
[00:29:10.544] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:10.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:78:0) after 1m0s
[00:30:10.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:78:0)
[00:30:10.580] Timer tick, asking Buildbucket for the build status
[00:30:11.013] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:11.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:79:0) after 1m0s
[00:31:11.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:79:0)
[00:31:11.035] Timer tick, asking Buildbucket for the build status
[00:31:11.484] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:11.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:80:0) after 1m0s
[00:32:11.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:80:0)
[00:32:11.528] Timer tick, asking Buildbucket for the build status
[00:32:11.735] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:11.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:81:0) after 1m0s
[00:33:11.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:81:0)
[00:33:11.757] Timer tick, asking Buildbucket for the build status
[00:33:12.009] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:12.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:82:0) after 1m0s
[00:34:12.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:82:0)
[00:34:12.035] Timer tick, asking Buildbucket for the build status
[00:34:13.117] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:13.117] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:83:0) after 1m0s
[00:35:13.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:83:0)
[00:35:13.163] Timer tick, asking Buildbucket for the build status
[00:35:13.841] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:13.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:84:0) after 1m0s
[00:36:13.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:84:0)
[00:36:13.865] Timer tick, asking Buildbucket for the build status
[00:36:14.114] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:14.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:85:0) after 1m0s
[00:37:14.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:85:0)
[00:37:14.115] Timer tick, asking Buildbucket for the build status
[00:37:14.616] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:14.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:86:0) after 1m0s
[00:38:14.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:86:0)
[00:38:14.745] Timer tick, asking Buildbucket for the build status
[00:38:15.122] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:15.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:87:0) after 1m0s
[00:39:15.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:87:0)
[00:39:15.240] Timer tick, asking Buildbucket for the build status
[00:39:15.491] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:15.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:88:0) after 1m0s
[00:40:15.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:88:0)
[00:40:15.627] Timer tick, asking Buildbucket for the build status
[00:40:15.829] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:15.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:89:0) after 1m0s
[00:41:15.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:89:0)
[00:41:15.931] Timer tick, asking Buildbucket for the build status
[00:41:16.330] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:16.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:90:0) after 1m0s
[00:42:16.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:90:0)
[00:42:16.437] Timer tick, asking Buildbucket for the build status
[00:42:16.560] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:16.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:91:0) after 1m0s
[00:43:16.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:91:0)
[00:43:16.684] Timer tick, asking Buildbucket for the build status
[00:43:16.924] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:16.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:92:0) after 1m0s
[00:44:17.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:92:0)
[00:44:17.064] Timer tick, asking Buildbucket for the build status
[00:44:17.461] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:17.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:93:0) after 1m0s
[00:45:17.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:93:0)
[00:45:17.487] Timer tick, asking Buildbucket for the build status
[00:45:17.647] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:17.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:94:0) after 1m0s
[00:46:17.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:94:0)
[00:46:17.721] Timer tick, asking Buildbucket for the build status
[00:46:18.277] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:18.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:95:0) after 1m0s
[00:47:18.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:95:0)
[00:47:18.427] Timer tick, asking Buildbucket for the build status
[00:47:20.519] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:20.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:96:0) after 1m0s
[00:48:20.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:96:0)
[00:48:20.600] Timer tick, asking Buildbucket for the build status
[00:48:20.855] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:20.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:97:0) after 1m0s
[00:49:20.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:97:0)
[00:49:20.946] Timer tick, asking Buildbucket for the build status
[00:49:21.245] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:21.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:98:0) after 1m0s
[00:50:21.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:98:0)
[00:50:21.267] Timer tick, asking Buildbucket for the build status
[00:50:21.598] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:21.598] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:99:0) after 1m0s
[00:51:21.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:99:0)
[00:51:21.696] Timer tick, asking Buildbucket for the build status
[00:51:22.339] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:22.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:100:0) after 1m0s
[00:52:22.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:100:0)
[00:52:22.334] Timer tick, asking Buildbucket for the build status
[00:52:22.490] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:22.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:101:0) after 1m0s
[00:53:22.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:101:0)
[00:53:22.519] Timer tick, asking Buildbucket for the build status
[00:53:22.819] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:22.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:102:0) after 1m0s
[00:54:22.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:102:0)
[00:54:22.874] Timer tick, asking Buildbucket for the build status
[00:54:23.393] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:23.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:103:0) after 1m0s
[00:55:23.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:103:0)
[00:55:23.502] Timer tick, asking Buildbucket for the build status
[00:55:23.834] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:23.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:104:0) after 1m0s
[00:56:23.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:104:0)
[00:56:23.911] Timer tick, asking Buildbucket for the build status
[00:56:27.065] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:27.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:105:0) after 1m0s
[00:57:27.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:105:0)
[00:57:27.094] Timer tick, asking Buildbucket for the build status
[00:57:27.273] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:27.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:106:0) after 1m0s
[00:58:27.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:106:0)
[00:58:27.335] Timer tick, asking Buildbucket for the build status
[00:58:27.607] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:27.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:107:0) after 1m0s
[00:59:27.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:107:0)
[00:59:27.622] Timer tick, asking Buildbucket for the build status
[00:59:28.199] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:28.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:108:0) after 1m0s
[01:00:28.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:108:0)
[01:00:28.264] Timer tick, asking Buildbucket for the build status
[01:00:28.622] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:28.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:109:0) after 1m0s
[01:01:28.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:109:0)
[01:01:28.615] Timer tick, asking Buildbucket for the build status
[01:01:28.999] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:28.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:110:0) after 1m0s
[01:02:29.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:110:0)
[01:02:29.088] Timer tick, asking Buildbucket for the build status
[01:02:29.404] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:29.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:111:0) after 1m0s
[01:03:29.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:111:0)
[01:03:29.481] Timer tick, asking Buildbucket for the build status
[01:03:29.750] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:29.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:112:0) after 1m0s
[01:04:29.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:112:0)
[01:04:29.832] Timer tick, asking Buildbucket for the build status
[01:04:31.565] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:31.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:113:0) after 1m0s
[01:05:31.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:113:0)
[01:05:31.589] Timer tick, asking Buildbucket for the build status
[01:05:32.295] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:32.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:114:0) after 1m0s
[01:06:32.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:114:0)
[01:06:32.375] Timer tick, asking Buildbucket for the build status
[01:06:32.729] Build 8882730435468110688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:32.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:115:0) after 1m0s
[01:06:34.021] Received PubSub notification, asking Buildbucket for the build status
[01:06:34.303] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:32.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:115:0)
[01:07:32.772] Timer tick, asking Buildbucket for the build status
[01:07:33.508] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:33.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:117:0) after 1m0s
[01:08:33.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:117:0)
[01:08:33.559] Timer tick, asking Buildbucket for the build status
[01:08:33.788] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:33.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:118:0) after 1m0s
[01:09:33.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:118:0)
[01:09:33.811] Timer tick, asking Buildbucket for the build status
[01:09:34.457] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:34.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:119:0) after 1m0s
[01:10:34.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:119:0)
[01:10:34.578] Timer tick, asking Buildbucket for the build status
[01:10:34.817] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:34.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:120:0) after 1m0s
[01:11:34.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:120:0)
[01:11:34.840] Timer tick, asking Buildbucket for the build status
[01:11:35.927] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:35.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:121:0) after 1m0s
[01:12:35.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:121:0)
[01:12:35.945] Timer tick, asking Buildbucket for the build status
[01:12:36.112] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:36.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:122:0) after 1m0s
[01:13:36.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:122:0)
[01:13:36.178] Timer tick, asking Buildbucket for the build status
[01:13:37.431] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:37.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:123:0) after 1m0s
[01:14:37.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:123:0)
[01:14:37.565] Timer tick, asking Buildbucket for the build status
[01:14:37.842] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:37.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:124:0) after 1m0s
[01:15:37.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:124:0)
[01:15:37.931] Timer tick, asking Buildbucket for the build status
[01:15:38.192] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:38.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:125:0) after 1m0s
[01:16:38.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:125:0)
[01:16:38.219] Timer tick, asking Buildbucket for the build status
[01:16:38.488] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:38.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:126:0) after 1m0s
[01:17:38.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:126:0)
[01:17:38.529] Timer tick, asking Buildbucket for the build status
[01:17:38.909] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:38.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:127:0) after 1m0s
[01:18:39.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:127:0)
[01:18:39.117] Timer tick, asking Buildbucket for the build status
[01:18:39.504] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:39.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:128:0) after 1m0s
[01:19:39.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:128:0)
[01:19:39.610] Timer tick, asking Buildbucket for the build status
[01:19:39.964] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:39.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:129:0) after 1m0s
[01:20:40.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:129:0)
[01:20:40.148] Timer tick, asking Buildbucket for the build status
[01:20:40.388] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:40.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:130:0) after 1m0s
[01:21:40.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:130:0)
[01:21:40.538] Timer tick, asking Buildbucket for the build status
[01:21:40.672] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:40.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:131:0) after 1m0s
[01:22:40.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:131:0)
[01:22:40.802] Timer tick, asking Buildbucket for the build status
[01:22:41.196] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:41.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:132:0) after 1m0s
[01:23:41.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:132:0)
[01:23:41.273] Timer tick, asking Buildbucket for the build status
[01:23:41.557] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:41.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:133:0) after 1m0s
[01:24:41.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:133:0)
[01:24:41.681] Timer tick, asking Buildbucket for the build status
[01:24:42.125] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:42.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:134:0) after 1m0s
[01:25:42.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:134:0)
[01:25:42.107] Timer tick, asking Buildbucket for the build status
[01:25:42.277] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:42.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:135:0) after 1m0s
[01:26:42.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:135:0)
[01:26:42.433] Timer tick, asking Buildbucket for the build status
[01:26:42.849] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:42.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:136:0) after 1m0s
[01:27:42.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:136:0)
[01:27:42.869] Timer tick, asking Buildbucket for the build status
[01:27:44.345] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:44.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:137:0) after 1m0s
[01:28:44.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:137:0)
[01:28:44.394] Timer tick, asking Buildbucket for the build status
[01:28:44.664] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:44.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:138:0) after 1m0s
[01:29:44.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:138:0)
[01:29:44.788] Timer tick, asking Buildbucket for the build status
[01:29:44.960] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:44.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:139:0) after 1m0s
[01:30:44.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:139:0)
[01:30:44.993] Timer tick, asking Buildbucket for the build status
[01:30:45.253] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:45.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:140:0) after 1m0s
[01:31:45.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:140:0)
[01:31:45.277] Timer tick, asking Buildbucket for the build status
[01:31:45.626] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:45.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:141:0) after 1m0s
[01:32:45.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:141:0)
[01:32:45.662] Timer tick, asking Buildbucket for the build status
[01:32:45.812] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:45.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:142:0) after 1m0s
[01:33:45.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:142:0)
[01:33:45.874] Timer tick, asking Buildbucket for the build status
[01:33:46.667] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:46.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:143:0) after 1m0s
[01:34:46.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:143:0)
[01:34:46.784] Timer tick, asking Buildbucket for the build status
[01:34:48.266] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:48.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:144:0) after 1m0s
[01:35:48.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:144:0)
[01:35:48.315] Timer tick, asking Buildbucket for the build status
[01:35:48.501] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:48.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:145:0) after 1m0s
[01:36:48.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:145:0)
[01:36:48.634] Timer tick, asking Buildbucket for the build status
[01:36:49.049] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:49.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:146:0) after 1m0s
[01:37:49.100] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:146:0)
[01:37:49.100] Timer tick, asking Buildbucket for the build status
[01:37:49.360] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:49.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:147:0) after 1m0s
[01:38:49.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:147:0)
[01:38:49.371] Timer tick, asking Buildbucket for the build status
[01:38:49.544] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:49.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:148:0) after 1m0s
[01:39:49.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:148:0)
[01:39:49.570] Timer tick, asking Buildbucket for the build status
[01:39:49.764] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:49.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:149:0) after 1m0s
[01:40:49.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:149:0)
[01:40:49.843] Timer tick, asking Buildbucket for the build status
[01:40:52.822] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:52.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:150:0) after 1m0s
[01:41:52.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:150:0)
[01:41:52.900] Timer tick, asking Buildbucket for the build status
[01:41:53.068] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:53.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:151:0) after 1m0s
[01:42:53.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:151:0)
[01:42:53.159] Timer tick, asking Buildbucket for the build status
[01:42:53.271] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:53.271] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:152:0) after 1m0s
[01:43:53.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:152:0)
[01:43:53.407] Timer tick, asking Buildbucket for the build status
[01:43:53.696] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:53.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:153:0) after 1m0s
[01:44:53.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:153:0)
[01:44:53.676] Timer tick, asking Buildbucket for the build status
[01:44:54.459] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:54.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:154:0) after 1m0s
[01:45:54.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:154:0)
[01:45:54.484] Timer tick, asking Buildbucket for the build status
[01:45:57.226] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:57.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:155:0) after 1m0s
[01:46:57.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:155:0)
[01:46:57.252] Timer tick, asking Buildbucket for the build status
[01:46:57.840] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:57.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:156:0) after 1m0s
[01:47:57.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:156:0)
[01:47:57.856] Timer tick, asking Buildbucket for the build status
[01:47:58.130] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:58.130] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:157:0) after 1m0s
[01:48:58.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:157:0)
[01:48:58.358] Timer tick, asking Buildbucket for the build status
[01:48:58.583] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:58.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:158:0) after 1m0s
[01:49:58.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:158:0)
[01:49:58.666] Timer tick, asking Buildbucket for the build status
[01:50:05.560] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:05.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:159:0) after 1m0s
[01:51:05.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:159:0)
[01:51:05.690] Timer tick, asking Buildbucket for the build status
[01:51:05.908] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:05.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:160:0) after 1m0s
[01:52:05.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:160:0)
[01:52:05.956] Timer tick, asking Buildbucket for the build status
[01:52:06.096] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:06.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:161:0) after 1m0s
[01:53:06.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:161:0)
[01:53:06.381] Timer tick, asking Buildbucket for the build status
[01:53:06.537] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:06.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:162:0) after 1m0s
[01:54:06.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:162:0)
[01:54:06.689] Timer tick, asking Buildbucket for the build status
[01:54:07.162] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:07.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:163:0) after 1m0s
[01:55:07.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:163:0)
[01:55:07.367] Timer tick, asking Buildbucket for the build status
[01:55:08.146] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:08.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:164:0) after 1m0s
[01:56:08.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:164:0)
[01:56:08.226] Timer tick, asking Buildbucket for the build status
[01:56:08.347] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:08.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:165:0) after 1m0s
[01:57:08.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:165:0)
[01:57:08.405] Timer tick, asking Buildbucket for the build status
[01:57:09.162] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:09.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:166:0) after 1m0s
[01:58:09.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:166:0)
[01:58:09.302] Timer tick, asking Buildbucket for the build status
[01:58:09.790] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:09.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:167:0) after 1m0s
[01:59:10.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:167:0)
[01:59:10.005] Timer tick, asking Buildbucket for the build status
[01:59:10.389] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:10.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:168:0) after 1m0s
[02:00:10.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:168:0)
[02:00:10.403] Timer tick, asking Buildbucket for the build status
[02:00:10.589] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:10.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:169:0) after 1m0s
[02:01:10.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:169:0)
[02:01:10.649] Timer tick, asking Buildbucket for the build status
[02:01:10.903] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:10.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:170:0) after 1m0s
[02:02:11.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:170:0)
[02:02:11.018] Timer tick, asking Buildbucket for the build status
[02:02:11.298] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:11.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:171:0) after 1m0s
[02:03:11.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:171:0)
[02:03:11.363] Timer tick, asking Buildbucket for the build status
[02:03:11.691] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:11.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:172:0) after 1m0s
[02:04:11.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:172:0)
[02:04:11.723] Timer tick, asking Buildbucket for the build status
[02:04:11.869] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:11.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:173:0) after 1m0s
[02:05:12.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:173:0)
[02:05:12.046] Timer tick, asking Buildbucket for the build status
[02:05:12.940] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:12.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:174:0) after 1m0s
[02:06:13.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:174:0)
[02:06:13.082] Timer tick, asking Buildbucket for the build status
[02:06:13.683] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:13.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:175:0) after 1m0s
[02:07:13.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:175:0)
[02:07:13.752] Timer tick, asking Buildbucket for the build status
[02:07:13.951] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:13.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:176:0) after 1m0s
[02:08:13.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:176:0)
[02:08:13.986] Timer tick, asking Buildbucket for the build status
[02:08:15.286] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:15.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:177:0) after 1m0s
[02:09:15.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:177:0)
[02:09:15.336] Timer tick, asking Buildbucket for the build status
[02:09:15.789] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:15.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:178:0) after 1m0s
[02:10:15.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:178:0)
[02:10:15.817] Timer tick, asking Buildbucket for the build status
[02:10:16.031] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:16.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:179:0) after 1m0s
[02:11:16.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:179:0)
[02:11:16.162] Timer tick, asking Buildbucket for the build status
[02:11:18.870] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:18.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:180:0) after 1m0s
[02:12:18.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:180:0)
[02:12:18.895] Timer tick, asking Buildbucket for the build status
[02:12:19.401] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:19.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:181:0) after 1m0s
[02:13:19.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:181:0)
[02:13:19.474] Timer tick, asking Buildbucket for the build status
[02:13:20.121] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:20.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:182:0) after 1m0s
[02:14:20.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:182:0)
[02:14:20.247] Timer tick, asking Buildbucket for the build status
[02:14:21.166] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:21.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:183:0) after 1m0s
[02:15:21.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:183:0)
[02:15:21.252] Timer tick, asking Buildbucket for the build status
[02:15:24.760] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:24.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:184:0) after 1m0s
[02:16:24.781] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:184:0)
[02:16:24.781] Timer tick, asking Buildbucket for the build status
[02:16:25.025] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:25.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:185:0) after 1m0s
[02:17:25.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:185:0)
[02:17:25.071] Timer tick, asking Buildbucket for the build status
[02:17:25.438] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:25.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:186:0) after 1m0s
[02:18:25.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:186:0)
[02:18:25.607] Timer tick, asking Buildbucket for the build status
[02:18:26.159] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:26.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:187:0) after 1m0s
[02:19:26.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:187:0)
[02:19:26.381] Timer tick, asking Buildbucket for the build status
[02:19:26.495] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:26.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:188:0) after 1m0s
[02:20:26.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:188:0)
[02:20:26.590] Timer tick, asking Buildbucket for the build status
[02:20:29.204] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:29.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:189:0) after 1m0s
[02:21:29.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:189:0)
[02:21:29.331] Timer tick, asking Buildbucket for the build status
[02:21:29.690] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:29.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:190:0) after 1m0s
[02:22:29.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:190:0)
[02:22:29.751] Timer tick, asking Buildbucket for the build status
[02:22:30.026] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:30.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:191:0) after 1m0s
[02:23:30.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:191:0)
[02:23:30.011] Timer tick, asking Buildbucket for the build status
[02:23:30.159] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:30.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:192:0) after 1m0s
[02:24:30.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:192:0)
[02:24:30.387] Timer tick, asking Buildbucket for the build status
[02:24:30.558] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:30.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:193:0) after 1m0s
[02:25:30.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:193:0)
[02:25:30.588] Timer tick, asking Buildbucket for the build status
[02:25:32.217] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:32.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:194:0) after 1m0s
[02:26:32.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:194:0)
[02:26:32.241] Timer tick, asking Buildbucket for the build status
[02:26:32.399] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:32.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:195:0) after 1m0s
[02:27:32.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:195:0)
[02:27:32.434] Timer tick, asking Buildbucket for the build status
[02:27:33.288] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:33.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:196:0) after 1m0s
[02:28:33.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:196:0)
[02:28:33.291] Timer tick, asking Buildbucket for the build status
[02:28:33.425] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:33.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:197:0) after 1m0s
[02:29:33.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:197:0)
[02:29:33.668] Timer tick, asking Buildbucket for the build status
[02:29:33.813] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:33.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:198:0) after 1m0s
[02:30:33.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:198:0)
[02:30:33.963] Timer tick, asking Buildbucket for the build status
[02:30:34.086] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:34.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:199:0) after 1m0s
[02:31:34.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:199:0)
[02:31:34.278] Timer tick, asking Buildbucket for the build status
[02:31:34.687] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:34.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:200:0) after 1m0s
[02:32:34.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:200:0)
[02:32:34.701] Timer tick, asking Buildbucket for the build status
[02:32:34.911] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:34.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:201:0) after 1m0s
[02:33:35.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:201:0)
[02:33:35.089] Timer tick, asking Buildbucket for the build status
[02:33:35.279] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:35.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:202:0) after 1m0s
[02:34:35.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:202:0)
[02:34:35.549] Timer tick, asking Buildbucket for the build status
[02:34:35.885] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:35.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:203:0) after 1m0s
[02:35:35.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:203:0)
[02:35:35.913] Timer tick, asking Buildbucket for the build status
[02:35:36.406] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:36.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:204:0) after 1m0s
[02:36:36.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:204:0)
[02:36:36.467] Timer tick, asking Buildbucket for the build status
[02:36:37.004] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:37.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:205:0) after 1m0s
[02:37:37.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:205:0)
[02:37:37.046] Timer tick, asking Buildbucket for the build status
[02:37:37.215] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:37.215] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:206:0) after 1m0s
[02:38:37.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:206:0)
[02:38:37.308] Timer tick, asking Buildbucket for the build status
[02:38:37.423] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:37.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:207:0) after 1m0s
[02:39:37.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:207:0)
[02:39:37.452] Timer tick, asking Buildbucket for the build status
[02:39:37.641] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:37.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:208:0) after 1m0s
[02:40:37.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:208:0)
[02:40:37.719] Timer tick, asking Buildbucket for the build status
[02:40:37.848] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:37.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:209:0) after 1m0s
[02:41:37.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:209:0)
[02:41:37.946] Timer tick, asking Buildbucket for the build status
[02:41:38.062] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:38.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:210:0) after 1m0s
[02:42:38.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:210:0)
[02:42:38.150] Timer tick, asking Buildbucket for the build status
[02:42:38.542] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:38.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:211:0) after 1m0s
[02:43:38.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:211:0)
[02:43:38.626] Timer tick, asking Buildbucket for the build status
[02:43:38.823] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:38.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:212:0) after 1m0s
[02:44:38.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:212:0)
[02:44:38.957] Timer tick, asking Buildbucket for the build status
[02:44:39.178] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:39.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:213:0) after 1m0s
[02:45:39.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:213:0)
[02:45:39.185] Timer tick, asking Buildbucket for the build status
[02:45:39.341] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:39.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:214:0) after 1m0s
[02:46:39.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:214:0)
[02:46:39.484] Timer tick, asking Buildbucket for the build status
[02:46:40.808] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:40.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:215:0) after 1m0s
[02:47:40.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:215:0)
[02:47:40.830] Timer tick, asking Buildbucket for the build status
[02:47:41.092] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:41.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:216:0) after 1m0s
[02:48:41.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:216:0)
[02:48:41.084] Timer tick, asking Buildbucket for the build status
[02:48:41.252] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:41.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:217:0) after 1m0s
[02:49:41.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:217:0)
[02:49:41.278] Timer tick, asking Buildbucket for the build status
[02:49:41.450] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:41.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:218:0) after 1m0s
[02:50:41.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:218:0)
[02:50:41.476] Timer tick, asking Buildbucket for the build status
[02:50:41.594] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:41.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:219:0) after 1m0s
[02:51:41.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:219:0)
[02:51:41.627] Timer tick, asking Buildbucket for the build status
[02:51:41.745] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:41.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:220:0) after 1m0s
[02:52:41.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:220:0)
[02:52:41.782] Timer tick, asking Buildbucket for the build status
[02:52:41.899] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:41.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:221:0) after 1m0s
[02:53:41.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:221:0)
[02:53:41.924] Timer tick, asking Buildbucket for the build status
[02:53:43.863] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:43.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:222:0) after 1m0s
[02:54:43.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:222:0)
[02:54:43.946] Timer tick, asking Buildbucket for the build status
[02:54:45.123] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:45.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:223:0) after 1m0s
[02:55:45.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:223:0)
[02:55:45.149] Timer tick, asking Buildbucket for the build status
[02:55:45.269] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:45.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:224:0) after 1m0s
[02:56:45.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:224:0)
[02:56:45.335] Timer tick, asking Buildbucket for the build status
[02:56:45.560] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:45.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:225:0) after 1m0s
[02:57:45.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:225:0)
[02:57:45.563] Timer tick, asking Buildbucket for the build status
[02:57:45.732] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:45.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:226:0) after 1m0s
[02:58:45.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:226:0)
[02:58:45.814] Timer tick, asking Buildbucket for the build status
[02:58:45.923] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:45.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:227:0) after 1m0s
[02:59:45.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:227:0)
[02:59:45.981] Timer tick, asking Buildbucket for the build status
[02:59:46.283] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:46.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:228:0) after 1m0s
[03:00:46.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:228:0)
[03:00:46.374] Timer tick, asking Buildbucket for the build status
[03:00:46.640] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:46.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:229:0) after 1m0s
[03:01:46.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:229:0)
[03:01:46.653] Timer tick, asking Buildbucket for the build status
[03:01:47.691] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:47.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:230:0) after 1m0s
[03:02:47.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:230:0)
[03:02:47.725] Timer tick, asking Buildbucket for the build status
[03:02:47.989] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:47.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:231:0) after 1m0s
[03:03:48.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:231:0)
[03:03:48.085] Timer tick, asking Buildbucket for the build status
[03:03:48.220] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:48.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:232:0) after 1m0s
[03:04:48.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:232:0)
[03:04:48.255] Timer tick, asking Buildbucket for the build status
[03:04:49.835] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:49.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:233:0) after 1m0s
[03:05:49.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:233:0)
[03:05:49.831] Timer tick, asking Buildbucket for the build status
[03:05:50.000] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:50.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:234:0) after 1m0s
[03:06:50.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:234:0)
[03:06:50.046] Timer tick, asking Buildbucket for the build status
[03:06:50.170] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:50.170] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:235:0) after 1m0s
[03:07:50.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:235:0)
[03:07:50.195] Timer tick, asking Buildbucket for the build status
[03:07:50.371] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:50.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:236:0) after 1m0s
[03:08:50.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:236:0)
[03:08:50.439] Timer tick, asking Buildbucket for the build status
[03:08:50.842] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:50.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:237:0) after 1m0s
[03:09:50.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:237:0)
[03:09:50.841] Timer tick, asking Buildbucket for the build status
[03:09:51.167] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:51.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:238:0) after 1m0s
[03:10:51.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:238:0)
[03:10:51.262] Timer tick, asking Buildbucket for the build status
[03:10:51.400] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:51.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:239:0) after 1m0s
[03:11:51.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:239:0)
[03:11:51.464] Timer tick, asking Buildbucket for the build status
[03:11:51.659] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:51.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:240:0) after 1m0s
[03:12:51.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:240:0)
[03:12:51.731] Timer tick, asking Buildbucket for the build status
[03:12:51.938] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:51.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:241:0) after 1m0s
[03:13:51.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:241:0)
[03:13:51.958] Timer tick, asking Buildbucket for the build status
[03:13:52.237] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:52.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:242:0) after 1m0s
[03:14:52.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:242:0)
[03:14:52.279] Timer tick, asking Buildbucket for the build status
[03:14:52.615] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:52.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:243:0) after 1m0s
[03:15:52.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:243:0)
[03:15:52.678] Timer tick, asking Buildbucket for the build status
[03:15:54.947] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:54.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:244:0) after 1m0s
[03:16:55.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:244:0)
[03:16:55.075] Timer tick, asking Buildbucket for the build status
[03:16:55.221] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:55.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:245:0) after 1m0s
[03:17:55.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:245:0)
[03:17:55.252] Timer tick, asking Buildbucket for the build status
[03:17:55.482] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:55.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:246:0) after 1m0s
[03:18:55.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:246:0)
[03:18:55.516] Timer tick, asking Buildbucket for the build status
[03:18:55.646] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:55.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:247:0) after 1m0s
[03:19:55.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:247:0)
[03:19:55.654] Timer tick, asking Buildbucket for the build status
[03:19:55.859] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:55.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:248:0) after 1m0s
[03:20:55.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:248:0)
[03:20:55.968] Timer tick, asking Buildbucket for the build status
[03:20:56.332] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:56.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:249:0) after 1m0s
[03:21:56.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:249:0)
[03:21:56.388] Timer tick, asking Buildbucket for the build status
[03:21:56.523] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:56.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:250:0) after 1m0s
[03:22:56.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:250:0)
[03:22:56.587] Timer tick, asking Buildbucket for the build status
[03:22:56.717] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:56.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:251:0) after 1m0s
[03:23:56.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:251:0)
[03:23:56.759] Timer tick, asking Buildbucket for the build status
[03:23:57.143] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:57.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:252:0) after 1m0s
[03:24:57.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:252:0)
[03:24:57.165] Timer tick, asking Buildbucket for the build status
[03:24:57.347] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:57.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:253:0) after 1m0s
[03:25:57.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:253:0)
[03:25:57.481] Timer tick, asking Buildbucket for the build status
[03:25:57.599] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:57.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:254:0) after 1m0s
[03:26:57.630] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:254:0)
[03:26:57.630] Timer tick, asking Buildbucket for the build status
[03:26:58.081] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:58.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:255:0) after 1m0s
[03:27:58.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:255:0)
[03:27:58.101] Timer tick, asking Buildbucket for the build status
[03:27:58.300] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:58.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:256:0) after 1m0s
[03:28:58.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:256:0)
[03:28:58.314] Timer tick, asking Buildbucket for the build status
[03:28:58.575] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:58.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:257:0) after 1m0s
[03:29:58.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:257:0)
[03:29:58.604] Timer tick, asking Buildbucket for the build status
[03:29:58.770] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:58.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:258:0) after 1m0s
[03:30:58.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:258:0)
[03:30:58.798] Timer tick, asking Buildbucket for the build status
[03:30:58.966] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:58.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:259:0) after 1m0s
[03:31:59.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:259:0)
[03:31:59.095] Timer tick, asking Buildbucket for the build status
[03:31:59.311] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:59.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:260:0) after 1m0s
[03:32:59.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:260:0)
[03:32:59.406] Timer tick, asking Buildbucket for the build status
[03:32:59.594] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:59.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:261:0) after 1m0s
[03:33:59.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:261:0)
[03:33:59.649] Timer tick, asking Buildbucket for the build status
[03:34:01.122] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:01.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:262:0) after 1m0s
[03:35:01.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:262:0)
[03:35:01.157] Timer tick, asking Buildbucket for the build status
[03:35:01.337] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:01.337] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:263:0) after 1m0s
[03:36:01.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:263:0)
[03:36:01.368] Timer tick, asking Buildbucket for the build status
[03:36:01.584] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:01.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:264:0) after 1m0s
[03:37:01.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:264:0)
[03:37:01.611] Timer tick, asking Buildbucket for the build status
[03:37:01.710] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:01.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:265:0) after 1m0s
[03:38:01.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:265:0)
[03:38:01.778] Timer tick, asking Buildbucket for the build status
[03:38:01.919] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:01.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:266:0) after 1m0s
[03:39:01.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:266:0)
[03:39:01.954] Timer tick, asking Buildbucket for the build status
[03:39:02.251] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:02.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:267:0) after 1m0s
[03:40:02.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:267:0)
[03:40:02.348] Timer tick, asking Buildbucket for the build status
[03:40:02.761] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:02.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:268:0) after 1m0s
[03:41:02.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:268:0)
[03:41:02.788] Timer tick, asking Buildbucket for the build status
[03:41:03.124] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:03.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:269:0) after 1m0s
[03:42:03.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:269:0)
[03:42:03.212] Timer tick, asking Buildbucket for the build status
[03:42:03.363] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:03.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:270:0) after 1m0s
[03:43:03.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:270:0)
[03:43:03.406] Timer tick, asking Buildbucket for the build status
[03:43:03.875] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:03.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:271:0) after 1m0s
[03:44:03.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:271:0)
[03:44:03.909] Timer tick, asking Buildbucket for the build status
[03:44:04.121] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:04.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:272:0) after 1m0s
[03:45:04.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:272:0)
[03:45:04.213] Timer tick, asking Buildbucket for the build status
[03:45:04.441] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:04.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:273:0) after 1m0s
[03:46:04.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:273:0)
[03:46:04.525] Timer tick, asking Buildbucket for the build status
[03:46:04.710] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:04.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:274:0) after 1m0s
[03:47:04.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:274:0)
[03:47:04.789] Timer tick, asking Buildbucket for the build status
[03:47:05.229] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:05.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:275:0) after 1m0s
[03:48:05.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:275:0)
[03:48:05.349] Timer tick, asking Buildbucket for the build status
[03:48:05.553] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:05.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:276:0) after 1m0s
[03:49:05.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:276:0)
[03:49:05.546] Timer tick, asking Buildbucket for the build status
[03:49:05.715] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:05.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:277:0) after 1m0s
[03:50:05.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:277:0)
[03:50:05.785] Timer tick, asking Buildbucket for the build status
[03:50:06.359] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:06.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:278:0) after 1m0s
[03:51:06.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:278:0)
[03:51:06.538] Timer tick, asking Buildbucket for the build status
[03:51:06.774] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:06.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:279:0) after 1m0s
[03:52:07.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:279:0)
[03:52:07.411] Timer tick, asking Buildbucket for the build status
[03:52:07.568] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:07.568] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:280:0) after 1m0s
[03:53:07.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:280:0)
[03:53:07.917] Timer tick, asking Buildbucket for the build status
[03:53:08.186] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:08.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:281:0) after 1m0s
[03:54:08.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:281:0)
[03:54:08.297] Timer tick, asking Buildbucket for the build status
[03:54:08.569] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:08.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:282:0) after 1m0s
[03:55:08.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:282:0)
[03:55:08.689] Timer tick, asking Buildbucket for the build status
[03:55:11.259] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:11.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:283:0) after 1m0s
[03:56:11.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:283:0)
[03:56:11.407] Timer tick, asking Buildbucket for the build status
[03:56:11.738] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:11.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:284:0) after 1m0s
[03:57:11.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:284:0)
[03:57:11.767] Timer tick, asking Buildbucket for the build status
[03:57:12.196] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:12.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:285:0) after 1m0s
[03:58:12.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:285:0)
[03:58:12.284] Timer tick, asking Buildbucket for the build status
[03:58:12.786] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:12.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:286:0) after 1m0s
[03:59:13.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:286:0)
[03:59:13.027] Timer tick, asking Buildbucket for the build status
[03:59:13.376] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:13.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:287:0) after 1m0s
[04:00:13.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:287:0)
[04:00:13.549] Timer tick, asking Buildbucket for the build status
[04:00:13.704] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:13.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:288:0) after 1m0s
[04:01:13.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:288:0)
[04:01:13.833] Timer tick, asking Buildbucket for the build status
[04:01:14.231] Build 8882730435468110688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:14.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048160497523902496:289:0) after 1m0s
[04:02:01.013] Received PubSub notification, asking Buildbucket for the build status
[04:02:01.752] Build 8882730435468110688: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:02:01.752] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1587182519703147",
"created_by": "project:infra",
"created_ts": "1587165146341829",
"id": "8882730435468110688",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4117.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ad13e1c7-1efc-4a25-9ff9-cbe6489e6809\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4117.2\"}}",
"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\": \"84.0.4117.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ad13e1c7-1efc-4a25-9ff9-cbe6489e6809\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-twpf\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"84.0.4117.2\"}, \"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-twpf\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"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\": [\"4985-2a273fe\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1587171992075272",
"status": "COMPLETED",
"status_changed_ts": "1587182520395914",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9048160497523902496",
"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/8882730435468110688/+/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:4ba33bed2060f110",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1587182520501273",
"url": "https://ci.chromium.org/b/8882730435468110688",
"utcnow_ts": "1587182521721359"
}
}
[04:02:01.752] Invocation finished in 4h49m36.75492375s with status SUCCEEDED