[08:48:15.307] New invocation is queued and will start shortly
[08:48:15.307] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:48:18.861] Starting the invocation (attempt 1)
[08:48:18.900] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:48:18.900] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:48:18.900] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9052110535435444512",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"82.0.4077.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"fc774050-fd53-4a2d-8676-475660100c33\",\"title\":\"publish_tarball/0\"}]},\"version\":\"82.0.4077.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:9052110535435444512",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[08:48:19.453] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1583398099044817",
"id": "8886680470854634336",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"82.0.4077.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"fc774050-fd53-4a2d-8676-475660100c33\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"82.0.4077.2\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583398099199303",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9052110535435444512",
"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/8886680470854634336/+/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": "1583398099199626",
"url": "https://ci.chromium.org/b/8886680470854634336",
"utcnow_ts": "1583398099440158"
}
}
[08:48:19.453] Task URL: https://ci.chromium.org/b/8886680470854634336
[08:48:19.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:2:0) after 1m0s
[08:48:25.611] Received PubSub notification, asking Buildbucket for the build status
[08:48:25.812] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:19.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:2:0)
[08:49:19.483] Timer tick, asking Buildbucket for the build status
[08:49:19.577] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:19.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:4:0) after 1m0s
[08:50:19.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:4:0)
[08:50:19.600] Timer tick, asking Buildbucket for the build status
[08:50:19.873] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:19.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:5:0) after 1m0s
[08:51:19.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:5:0)
[08:51:19.963] Timer tick, asking Buildbucket for the build status
[08:51:20.470] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:20.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:6:0) after 1m0s
[08:52:20.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:6:0)
[08:52:20.567] Timer tick, asking Buildbucket for the build status
[08:52:20.856] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:20.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:7:0) after 1m0s
[08:53:20.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:7:0)
[08:53:20.915] Timer tick, asking Buildbucket for the build status
[08:53:21.577] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:21.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:8:0) after 1m0s
[08:54:21.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:8:0)
[08:54:21.558] Timer tick, asking Buildbucket for the build status
[08:54:21.720] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:21.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:9:0) after 1m0s
[08:55:21.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:9:0)
[08:55:21.747] Timer tick, asking Buildbucket for the build status
[08:55:21.885] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:21.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:10:0) after 1m0s
[08:56:21.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:10:0)
[08:56:21.939] Timer tick, asking Buildbucket for the build status
[08:56:22.225] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:22.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:11:0) after 1m0s
[08:57:22.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:11:0)
[08:57:22.249] Timer tick, asking Buildbucket for the build status
[08:57:22.518] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:22.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:12:0) after 1m0s
[08:58:22.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:12:0)
[08:58:22.559] Timer tick, asking Buildbucket for the build status
[08:58:23.152] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:23.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:13:0) after 1m0s
[08:59:23.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:13:0)
[08:59:23.161] Timer tick, asking Buildbucket for the build status
[08:59:23.497] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:23.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:14:0) after 1m0s
[09:00:23.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:14:0)
[09:00:23.647] Timer tick, asking Buildbucket for the build status
[09:00:23.891] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:23.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:15:0) after 1m0s
[09:01:23.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:15:0)
[09:01:23.958] Timer tick, asking Buildbucket for the build status
[09:01:24.080] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:24.080] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:16:0) after 1m0s
[09:02:24.130] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:16:0)
[09:02:24.130] Timer tick, asking Buildbucket for the build status
[09:02:24.533] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:24.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:17:0) after 1m0s
[09:03:24.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:17:0)
[09:03:24.551] Timer tick, asking Buildbucket for the build status
[09:03:25.715] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:25.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:18:0) after 1m0s
[09:04:25.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:18:0)
[09:04:25.719] Timer tick, asking Buildbucket for the build status
[09:04:25.942] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:25.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:19:0) after 1m0s
[09:05:26.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:19:0)
[09:05:26.012] Timer tick, asking Buildbucket for the build status
[09:05:26.290] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:26.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:20:0) after 1m0s
[09:06:26.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:20:0)
[09:06:26.347] Timer tick, asking Buildbucket for the build status
[09:06:26.520] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:26.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:21:0) after 1m0s
[09:07:26.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:21:0)
[09:07:26.614] Timer tick, asking Buildbucket for the build status
[09:07:26.739] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:26.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:22:0) after 1m0s
[09:08:26.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:22:0)
[09:08:26.779] Timer tick, asking Buildbucket for the build status
[09:08:26.902] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:26.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:23:0) after 1m0s
[09:09:26.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:23:0)
[09:09:26.924] Timer tick, asking Buildbucket for the build status
[09:09:27.303] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:27.303] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:24:0) after 1m0s
[09:10:27.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:24:0)
[09:10:27.421] Timer tick, asking Buildbucket for the build status
[09:10:27.515] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:27.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:25:0) after 1m0s
[09:11:27.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:25:0)
[09:11:27.573] Timer tick, asking Buildbucket for the build status
[09:11:27.710] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:27.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:26:0) after 1m0s
[09:12:27.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:26:0)
[09:12:27.762] Timer tick, asking Buildbucket for the build status
[09:12:27.859] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:27.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:27:0) after 1m0s
[09:13:27.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:27:0)
[09:13:27.857] Timer tick, asking Buildbucket for the build status
[09:13:28.213] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:28.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:28:0) after 1m0s
[09:14:28.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:28:0)
[09:14:28.263] Timer tick, asking Buildbucket for the build status
[09:14:28.371] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:28.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:29:0) after 1m0s
[09:15:28.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:29:0)
[09:15:28.432] Timer tick, asking Buildbucket for the build status
[09:15:28.723] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:28.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:30:0) after 1m0s
[09:16:28.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:30:0)
[09:16:28.763] Timer tick, asking Buildbucket for the build status
[09:16:29.184] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:29.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:31:0) after 1m0s
[09:17:29.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:31:0)
[09:17:29.324] Timer tick, asking Buildbucket for the build status
[09:17:29.536] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:29.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:32:0) after 1m0s
[09:18:30.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:32:0)
[09:18:30.771] Timer tick, asking Buildbucket for the build status
[09:18:30.887] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:30.887] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:33:0) after 1m0s
[09:19:30.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:33:0)
[09:19:30.963] Timer tick, asking Buildbucket for the build status
[09:19:31.150] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:31.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:34:0) after 1m0s
[09:20:31.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:34:0)
[09:20:31.201] Timer tick, asking Buildbucket for the build status
[09:20:31.329] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:31.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:35:0) after 1m0s
[09:21:31.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:35:0)
[09:21:31.353] Timer tick, asking Buildbucket for the build status
[09:21:31.465] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:31.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:36:0) after 1m0s
[09:22:31.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:36:0)
[09:22:31.561] Timer tick, asking Buildbucket for the build status
[09:22:31.660] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:31.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:37:0) after 1m0s
[09:23:31.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:37:0)
[09:23:31.985] Timer tick, asking Buildbucket for the build status
[09:23:32.373] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:32.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:38:0) after 1m0s
[09:24:32.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:38:0)
[09:24:32.454] Timer tick, asking Buildbucket for the build status
[09:24:32.682] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:32.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:39:0) after 1m0s
[09:25:32.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:39:0)
[09:25:32.730] Timer tick, asking Buildbucket for the build status
[09:25:32.883] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:32.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:40:0) after 1m0s
[09:26:32.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:40:0)
[09:26:32.969] Timer tick, asking Buildbucket for the build status
[09:26:33.050] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:33.050] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:41:0) after 1m0s
[09:27:33.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:41:0)
[09:27:33.082] Timer tick, asking Buildbucket for the build status
[09:27:35.393] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:35.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:42:0) after 1m0s
[09:28:35.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:42:0)
[09:28:35.546] Timer tick, asking Buildbucket for the build status
[09:28:36.087] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:36.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:43:0) after 1m0s
[09:29:36.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:43:0)
[09:29:36.148] Timer tick, asking Buildbucket for the build status
[09:29:36.378] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:36.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:44:0) after 1m0s
[09:30:36.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:44:0)
[09:30:36.434] Timer tick, asking Buildbucket for the build status
[09:30:37.309] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:37.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:45:0) after 1m0s
[09:31:37.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:45:0)
[09:31:37.347] Timer tick, asking Buildbucket for the build status
[09:31:37.515] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:37.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:46:0) after 1m0s
[09:32:37.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:46:0)
[09:32:37.614] Timer tick, asking Buildbucket for the build status
[09:32:37.707] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:37.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:47:0) after 1m0s
[09:33:37.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:47:0)
[09:33:37.728] Timer tick, asking Buildbucket for the build status
[09:33:37.851] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:37.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:48:0) after 1m0s
[09:34:37.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:48:0)
[09:34:37.873] Timer tick, asking Buildbucket for the build status
[09:34:37.979] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:37.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:49:0) after 1m0s
[09:35:37.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:49:0)
[09:35:37.958] Timer tick, asking Buildbucket for the build status
[09:35:38.344] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:38.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:50:0) after 1m0s
[09:36:38.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:50:0)
[09:36:38.379] Timer tick, asking Buildbucket for the build status
[09:36:38.664] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:38.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:51:0) after 1m0s
[09:37:38.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:51:0)
[09:37:38.704] Timer tick, asking Buildbucket for the build status
[09:37:38.901] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:38.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:52:0) after 1m0s
[09:38:39.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:52:0)
[09:38:39.016] Timer tick, asking Buildbucket for the build status
[09:38:39.126] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:39.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:53:0) after 1m0s
[09:39:39.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:53:0)
[09:39:39.117] Timer tick, asking Buildbucket for the build status
[09:39:39.220] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:39.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:54:0) after 1m0s
[09:40:39.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:54:0)
[09:40:39.211] Timer tick, asking Buildbucket for the build status
[09:40:39.314] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:39.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:55:0) after 1m0s
[09:41:39.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:55:0)
[09:41:39.343] Timer tick, asking Buildbucket for the build status
[09:41:39.497] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:39.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:56:0) after 1m0s
[09:42:39.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:56:0)
[09:42:39.522] Timer tick, asking Buildbucket for the build status
[09:42:39.829] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:39.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:57:0) after 1m0s
[09:43:39.926] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:57:0)
[09:43:39.926] Timer tick, asking Buildbucket for the build status
[09:43:40.127] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:40.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:58:0) after 1m0s
[09:44:40.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:58:0)
[09:44:40.158] Timer tick, asking Buildbucket for the build status
[09:44:40.478] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:40.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:59:0) after 1m0s
[09:45:40.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:59:0)
[09:45:40.505] Timer tick, asking Buildbucket for the build status
[09:45:40.760] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:40.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:60:0) after 1m0s
[09:46:40.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:60:0)
[09:46:40.746] Timer tick, asking Buildbucket for the build status
[09:46:40.979] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:40.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:61:0) after 1m0s
[09:47:41.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:61:0)
[09:47:41.039] Timer tick, asking Buildbucket for the build status
[09:47:41.154] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:41.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:62:0) after 1m0s
[09:48:41.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:62:0)
[09:48:41.227] Timer tick, asking Buildbucket for the build status
[09:48:41.353] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:41.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:63:0) after 1m0s
[09:49:41.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:63:0)
[09:49:41.425] Timer tick, asking Buildbucket for the build status
[09:49:41.620] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:41.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:64:0) after 1m0s
[09:50:41.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:64:0)
[09:50:41.676] Timer tick, asking Buildbucket for the build status
[09:50:41.770] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:41.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:65:0) after 1m0s
[09:51:41.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:65:0)
[09:51:41.794] Timer tick, asking Buildbucket for the build status
[09:51:42.055] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:42.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:66:0) after 1m0s
[09:52:42.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:66:0)
[09:52:42.082] Timer tick, asking Buildbucket for the build status
[09:52:42.362] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:42.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:67:0) after 1m0s
[09:53:42.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:67:0)
[09:53:42.381] Timer tick, asking Buildbucket for the build status
[09:53:42.558] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:42.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:68:0) after 1m0s
[09:54:42.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:68:0)
[09:54:42.648] Timer tick, asking Buildbucket for the build status
[09:54:42.773] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:42.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:69:0) after 1m0s
[09:55:42.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:69:0)
[09:55:42.819] Timer tick, asking Buildbucket for the build status
[09:55:42.966] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:42.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:70:0) after 1m0s
[09:56:42.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:70:0)
[09:56:42.991] Timer tick, asking Buildbucket for the build status
[09:56:43.147] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:43.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:71:0) after 1m0s
[09:57:43.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:71:0)
[09:57:43.176] Timer tick, asking Buildbucket for the build status
[09:57:43.427] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:43.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:72:0) after 1m0s
[09:58:43.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:72:0)
[09:58:43.463] Timer tick, asking Buildbucket for the build status
[09:58:43.665] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:43.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:73:0) after 1m0s
[09:59:43.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:73:0)
[09:59:43.688] Timer tick, asking Buildbucket for the build status
[09:59:43.827] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:43.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:74:0) after 1m0s
[10:00:43.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:74:0)
[10:00:43.875] Timer tick, asking Buildbucket for the build status
[10:00:44.304] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:44.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:75:0) after 1m0s
[10:01:44.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:75:0)
[10:01:44.457] Timer tick, asking Buildbucket for the build status
[10:01:44.568] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:44.568] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:76:0) after 1m0s
[10:02:44.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:76:0)
[10:02:44.658] Timer tick, asking Buildbucket for the build status
[10:02:44.767] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:44.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:77:0) after 1m0s
[10:03:44.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:77:0)
[10:03:44.981] Timer tick, asking Buildbucket for the build status
[10:03:45.092] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:45.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:78:0) after 1m0s
[10:04:45.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:78:0)
[10:04:45.149] Timer tick, asking Buildbucket for the build status
[10:04:45.347] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:45.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:79:0) after 1m0s
[10:05:45.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:79:0)
[10:05:45.373] Timer tick, asking Buildbucket for the build status
[10:05:45.544] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:45.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:80:0) after 1m0s
[10:06:45.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:80:0)
[10:06:45.587] Timer tick, asking Buildbucket for the build status
[10:06:45.689] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:45.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:81:0) after 1m0s
[10:07:45.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:81:0)
[10:07:45.716] Timer tick, asking Buildbucket for the build status
[10:07:46.619] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:46.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:82:0) after 1m0s
[10:08:46.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:82:0)
[10:08:46.755] Timer tick, asking Buildbucket for the build status
[10:08:47.167] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:47.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:83:0) after 1m0s
[10:09:47.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:83:0)
[10:09:47.345] Timer tick, asking Buildbucket for the build status
[10:09:47.470] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:47.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:84:0) after 1m0s
[10:10:47.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:84:0)
[10:10:47.523] Timer tick, asking Buildbucket for the build status
[10:10:47.622] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:47.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:85:0) after 1m0s
[10:11:47.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:85:0)
[10:11:47.649] Timer tick, asking Buildbucket for the build status
[10:11:47.773] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:47.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:86:0) after 1m0s
[10:12:47.799] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:86:0)
[10:12:47.799] Timer tick, asking Buildbucket for the build status
[10:12:47.928] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:47.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:87:0) after 1m0s
[10:13:47.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:87:0)
[10:13:47.946] Timer tick, asking Buildbucket for the build status
[10:13:48.044] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:48.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:88:0) after 1m0s
[10:14:48.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:88:0)
[10:14:48.125] Timer tick, asking Buildbucket for the build status
[10:14:48.231] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:48.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:89:0) after 1m0s
[10:15:48.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:89:0)
[10:15:48.257] Timer tick, asking Buildbucket for the build status
[10:15:48.355] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:48.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:90:0) after 1m0s
[10:16:48.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:90:0)
[10:16:48.949] Timer tick, asking Buildbucket for the build status
[10:16:49.153] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:49.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:91:0) after 1m0s
[10:17:49.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:91:0)
[10:17:49.245] Timer tick, asking Buildbucket for the build status
[10:17:49.337] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:49.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:92:0) after 1m0s
[10:18:49.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:92:0)
[10:18:49.368] Timer tick, asking Buildbucket for the build status
[10:18:49.486] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:49.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:93:0) after 1m0s
[10:19:49.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:93:0)
[10:19:49.515] Timer tick, asking Buildbucket for the build status
[10:19:49.610] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:49.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:94:0) after 1m0s
[10:20:49.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:94:0)
[10:20:49.671] Timer tick, asking Buildbucket for the build status
[10:20:49.871] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:49.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:95:0) after 1m0s
[10:21:49.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:95:0)
[10:21:49.922] Timer tick, asking Buildbucket for the build status
[10:21:50.011] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:50.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:96:0) after 1m0s
[10:22:50.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:96:0)
[10:22:50.080] Timer tick, asking Buildbucket for the build status
[10:22:50.218] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:50.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:97:0) after 1m0s
[10:23:50.222] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:97:0)
[10:23:50.222] Timer tick, asking Buildbucket for the build status
[10:23:50.598] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:50.598] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:98:0) after 1m0s
[10:24:50.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:98:0)
[10:24:50.648] Timer tick, asking Buildbucket for the build status
[10:24:50.745] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:50.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:99:0) after 1m0s
[10:25:50.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:99:0)
[10:25:50.811] Timer tick, asking Buildbucket for the build status
[10:25:51.054] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:51.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:100:0) after 1m0s
[10:26:51.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:100:0)
[10:26:51.052] Timer tick, asking Buildbucket for the build status
[10:26:51.298] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:51.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:101:0) after 1m0s
[10:27:51.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:101:0)
[10:27:51.319] Timer tick, asking Buildbucket for the build status
[10:27:51.424] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:51.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:102:0) after 1m0s
[10:28:51.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:102:0)
[10:28:51.438] Timer tick, asking Buildbucket for the build status
[10:28:51.533] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:51.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:103:0) after 1m0s
[10:29:51.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:103:0)
[10:29:51.612] Timer tick, asking Buildbucket for the build status
[10:29:51.744] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:51.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:104:0) after 1m0s
[10:30:51.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:104:0)
[10:30:51.835] Timer tick, asking Buildbucket for the build status
[10:30:52.077] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:52.077] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:105:0) after 1m0s
[10:31:52.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:105:0)
[10:31:52.177] Timer tick, asking Buildbucket for the build status
[10:31:52.383] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:52.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:106:0) after 1m0s
[10:32:52.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:106:0)
[10:32:52.475] Timer tick, asking Buildbucket for the build status
[10:32:52.561] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:52.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:107:0) after 1m0s
[10:33:52.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:107:0)
[10:33:52.695] Timer tick, asking Buildbucket for the build status
[10:33:53.071] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:53.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:108:0) after 1m0s
[10:34:53.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:108:0)
[10:34:53.117] Timer tick, asking Buildbucket for the build status
[10:34:53.453] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:53.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:109:0) after 1m0s
[10:35:53.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:109:0)
[10:35:53.487] Timer tick, asking Buildbucket for the build status
[10:35:53.968] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:53.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:110:0) after 1m0s
[10:36:53.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:110:0)
[10:36:53.986] Timer tick, asking Buildbucket for the build status
[10:36:54.096] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:54.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:111:0) after 1m0s
[10:37:54.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:111:0)
[10:37:54.189] Timer tick, asking Buildbucket for the build status
[10:37:54.500] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:54.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:112:0) after 1m0s
[10:38:54.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:112:0)
[10:38:54.522] Timer tick, asking Buildbucket for the build status
[10:38:54.696] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:54.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:113:0) after 1m0s
[10:39:54.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:113:0)
[10:39:54.735] Timer tick, asking Buildbucket for the build status
[10:39:54.894] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:54.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:114:0) after 1m0s
[10:40:55.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:114:0)
[10:40:55.018] Timer tick, asking Buildbucket for the build status
[10:40:55.318] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:55.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:115:0) after 1m0s
[10:41:55.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:115:0)
[10:41:55.304] Timer tick, asking Buildbucket for the build status
[10:41:55.433] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:55.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:116:0) after 1m0s
[10:42:55.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:116:0)
[10:42:55.474] Timer tick, asking Buildbucket for the build status
[10:42:55.881] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:55.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:117:0) after 1m0s
[10:43:55.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:117:0)
[10:43:55.906] Timer tick, asking Buildbucket for the build status
[10:43:56.013] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:56.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:118:0) after 1m0s
[10:44:56.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:118:0)
[10:44:56.049] Timer tick, asking Buildbucket for the build status
[10:44:56.148] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:56.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:119:0) after 1m0s
[10:45:56.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:119:0)
[10:45:56.272] Timer tick, asking Buildbucket for the build status
[10:45:56.684] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:56.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:120:0) after 1m0s
[10:46:56.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:120:0)
[10:46:56.717] Timer tick, asking Buildbucket for the build status
[10:46:57.993] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:57.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:121:0) after 1m0s
[10:47:58.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:121:0)
[10:47:58.024] Timer tick, asking Buildbucket for the build status
[10:47:58.158] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:58.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:122:0) after 1m0s
[10:48:58.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:122:0)
[10:48:58.163] Timer tick, asking Buildbucket for the build status
[10:48:58.501] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:58.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:123:0) after 1m0s
[10:49:58.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:123:0)
[10:49:58.523] Timer tick, asking Buildbucket for the build status
[10:49:58.688] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:58.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:124:0) after 1m0s
[10:50:58.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:124:0)
[10:50:58.839] Timer tick, asking Buildbucket for the build status
[10:50:59.365] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:59.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:125:0) after 1m0s
[10:51:59.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:125:0)
[10:51:59.400] Timer tick, asking Buildbucket for the build status
[10:51:59.564] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:59.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:126:0) after 1m0s
[10:52:59.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:126:0)
[10:52:59.609] Timer tick, asking Buildbucket for the build status
[10:53:00.174] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:00.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:127:0) after 1m0s
[10:54:00.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:127:0)
[10:54:00.282] Timer tick, asking Buildbucket for the build status
[10:54:00.625] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:00.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:128:0) after 1m0s
[10:55:00.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:128:0)
[10:55:00.682] Timer tick, asking Buildbucket for the build status
[10:55:00.776] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:00.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:129:0) after 1m0s
[10:56:00.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:129:0)
[10:56:00.841] Timer tick, asking Buildbucket for the build status
[10:56:01.194] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:01.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:130:0) after 1m0s
[10:57:01.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:130:0)
[10:57:01.277] Timer tick, asking Buildbucket for the build status
[10:57:01.407] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:01.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:131:0) after 1m0s
[10:58:01.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:131:0)
[10:58:01.448] Timer tick, asking Buildbucket for the build status
[10:58:01.569] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:01.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:132:0) after 1m0s
[10:59:01.598] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:132:0)
[10:59:01.598] Timer tick, asking Buildbucket for the build status
[10:59:02.129] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:02.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:133:0) after 1m0s
[11:00:02.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:133:0)
[11:00:02.164] Timer tick, asking Buildbucket for the build status
[11:00:02.611] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:02.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:134:0) after 1m0s
[11:01:02.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:134:0)
[11:01:02.703] Timer tick, asking Buildbucket for the build status
[11:01:03.038] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:03.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:135:0) after 1m0s
[11:02:03.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:135:0)
[11:02:03.143] Timer tick, asking Buildbucket for the build status
[11:02:03.618] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:03.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:136:0) after 1m0s
[11:03:03.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:136:0)
[11:03:03.662] Timer tick, asking Buildbucket for the build status
[11:03:03.778] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:03.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:137:0) after 1m0s
[11:04:03.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:137:0)
[11:04:03.850] Timer tick, asking Buildbucket for the build status
[11:04:03.979] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:03.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:138:0) after 1m0s
[11:05:03.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:138:0)
[11:05:03.998] Timer tick, asking Buildbucket for the build status
[11:05:04.163] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:04.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:139:0) after 1m0s
[11:06:04.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:139:0)
[11:06:04.225] Timer tick, asking Buildbucket for the build status
[11:06:04.436] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:04.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:140:0) after 1m0s
[11:07:04.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:140:0)
[11:07:04.564] Timer tick, asking Buildbucket for the build status
[11:07:04.708] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:04.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:141:0) after 1m0s
[11:08:04.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:141:0)
[11:08:04.689] Timer tick, asking Buildbucket for the build status
[11:08:04.853] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:04.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:142:0) after 1m0s
[11:09:05.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:142:0)
[11:09:05.059] Timer tick, asking Buildbucket for the build status
[11:09:05.206] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:05.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:143:0) after 1m0s
[11:10:05.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:143:0)
[11:10:05.386] Timer tick, asking Buildbucket for the build status
[11:10:05.586] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:05.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:144:0) after 1m0s
[11:11:05.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:144:0)
[11:11:05.724] Timer tick, asking Buildbucket for the build status
[11:11:05.868] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:05.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:145:0) after 1m0s
[11:12:05.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:145:0)
[11:12:05.900] Timer tick, asking Buildbucket for the build status
[11:12:06.096] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:06.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:146:0) after 1m0s
[11:13:06.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:146:0)
[11:13:06.125] Timer tick, asking Buildbucket for the build status
[11:13:06.311] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:06.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:147:0) after 1m0s
[11:14:06.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:147:0)
[11:14:06.379] Timer tick, asking Buildbucket for the build status
[11:14:06.652] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:06.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:148:0) after 1m0s
[11:15:06.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:148:0)
[11:15:06.827] Timer tick, asking Buildbucket for the build status
[11:15:08.236] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:08.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:149:0) after 1m0s
[11:16:08.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:149:0)
[11:16:08.299] Timer tick, asking Buildbucket for the build status
[11:16:08.512] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:08.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:150:0) after 1m0s
[11:17:08.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:150:0)
[11:17:08.646] Timer tick, asking Buildbucket for the build status
[11:17:09.072] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:09.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:151:0) after 1m0s
[11:18:09.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:151:0)
[11:18:09.105] Timer tick, asking Buildbucket for the build status
[11:18:09.360] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:09.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:152:0) after 1m0s
[11:19:09.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:152:0)
[11:19:09.582] Timer tick, asking Buildbucket for the build status
[11:19:09.870] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:09.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:153:0) after 1m0s
[11:20:09.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:153:0)
[11:20:09.971] Timer tick, asking Buildbucket for the build status
[11:20:10.086] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:10.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:154:0) after 1m0s
[11:21:10.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:154:0)
[11:21:10.151] Timer tick, asking Buildbucket for the build status
[11:21:10.324] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:10.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:155:0) after 1m0s
[11:22:10.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:155:0)
[11:22:10.385] Timer tick, asking Buildbucket for the build status
[11:22:10.663] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:10.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:156:0) after 1m0s
[11:23:10.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:156:0)
[11:23:10.662] Timer tick, asking Buildbucket for the build status
[11:23:10.862] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:10.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:157:0) after 1m0s
[11:24:11.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:157:0)
[11:24:11.054] Timer tick, asking Buildbucket for the build status
[11:24:11.144] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:11.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:158:0) after 1m0s
[11:25:11.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:158:0)
[11:25:11.208] Timer tick, asking Buildbucket for the build status
[11:25:11.637] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:11.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:159:0) after 1m0s
[11:26:11.663] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:159:0)
[11:26:11.663] Timer tick, asking Buildbucket for the build status
[11:26:11.869] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:11.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:160:0) after 1m0s
[11:27:11.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:160:0)
[11:27:11.986] Timer tick, asking Buildbucket for the build status
[11:27:12.162] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:12.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:161:0) after 1m0s
[11:28:12.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:161:0)
[11:28:12.197] Timer tick, asking Buildbucket for the build status
[11:28:12.294] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:12.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:162:0) after 1m0s
[11:29:12.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:162:0)
[11:29:12.317] Timer tick, asking Buildbucket for the build status
[11:29:12.560] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:12.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:163:0) after 1m0s
[11:30:12.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:163:0)
[11:30:12.592] Timer tick, asking Buildbucket for the build status
[11:30:12.918] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:12.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:164:0) after 1m0s
[11:31:12.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:164:0)
[11:31:12.936] Timer tick, asking Buildbucket for the build status
[11:31:13.713] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:13.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:165:0) after 1m0s
[11:32:13.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:165:0)
[11:32:13.758] Timer tick, asking Buildbucket for the build status
[11:32:13.920] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:13.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:166:0) after 1m0s
[11:33:13.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:166:0)
[11:33:13.976] Timer tick, asking Buildbucket for the build status
[11:33:14.304] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:14.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:167:0) after 1m0s
[11:34:14.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:167:0)
[11:34:14.455] Timer tick, asking Buildbucket for the build status
[11:34:15.086] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:15.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:168:0) after 1m0s
[11:35:16.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:168:0)
[11:35:16.618] Timer tick, asking Buildbucket for the build status
[11:35:16.713] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:16.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:169:0) after 1m0s
[11:36:17.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:169:0)
[11:36:17.097] Timer tick, asking Buildbucket for the build status
[11:36:17.291] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:17.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:170:0) after 1m0s
[11:37:17.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:170:0)
[11:37:17.441] Timer tick, asking Buildbucket for the build status
[11:37:17.739] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:17.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:171:0) after 1m0s
[11:38:17.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:171:0)
[11:38:17.819] Timer tick, asking Buildbucket for the build status
[11:38:18.084] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:18.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:172:0) after 1m0s
[11:39:18.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:172:0)
[11:39:18.145] Timer tick, asking Buildbucket for the build status
[11:39:18.477] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:18.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:173:0) after 1m0s
[11:40:18.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:173:0)
[11:40:18.694] Timer tick, asking Buildbucket for the build status
[11:40:18.846] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:18.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:174:0) after 1m0s
[11:41:18.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:174:0)
[11:41:18.957] Timer tick, asking Buildbucket for the build status
[11:41:19.064] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:19.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:175:0) after 1m0s
[11:42:19.121] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:175:0)
[11:42:19.121] Timer tick, asking Buildbucket for the build status
[11:42:19.211] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:19.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:176:0) after 1m0s
[11:43:19.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:176:0)
[11:43:19.331] Timer tick, asking Buildbucket for the build status
[11:43:19.687] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:19.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:177:0) after 1m0s
[11:44:19.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:177:0)
[11:44:19.803] Timer tick, asking Buildbucket for the build status
[11:44:19.933] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:19.933] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:178:0) after 1m0s
[11:45:19.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:178:0)
[11:45:19.986] Timer tick, asking Buildbucket for the build status
[11:45:20.097] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:20.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:179:0) after 1m0s
[11:46:20.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:179:0)
[11:46:20.173] Timer tick, asking Buildbucket for the build status
[11:46:20.392] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:20.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:180:0) after 1m0s
[11:47:20.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:180:0)
[11:47:20.473] Timer tick, asking Buildbucket for the build status
[11:47:20.888] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:20.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:181:0) after 1m0s
[11:48:20.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:181:0)
[11:48:20.968] Timer tick, asking Buildbucket for the build status
[11:48:21.217] Build 8886680470854634336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:21.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052110535435444512:182:0) after 1m0s
[11:49:14.324] Received PubSub notification, asking Buildbucket for the build status
[11:49:14.389] Build 8886680470854634336: status "COMPLETED", result "CANCELED", failure_reason "", cancelation_reason "TIMEOUT"
[11:49:14.389] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"cancelation_reason": "TIMEOUT",
"completed_ts": "1583408953268082",
"created_by": "project:infra",
"created_ts": "1583398099044817",
"id": "8886680470854634336",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"82.0.4077.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"fc774050-fd53-4a2d-8676-475660100c33\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"82.0.4077.2\"}}",
"project": "infra",
"result": "CANCELED",
"result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"82.0.4077.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"fc774050-fd53-4a2d-8676-475660100c33\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-skcl\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"82.0.4077.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-skcl\"], \"image\": [\"chrome-xenial-20030100-2bddf837f90\"], \"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\": [\"4851-268d16b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583398104656411",
"status": "COMPLETED",
"status_changed_ts": "1583408953635040",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9052110535435444512",
"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/8886680470854634336/+/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:4ac2b3226dd5b610",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1583408953649388",
"url": "https://ci.chromium.org/b/8886680470854634336",
"utcnow_ts": "1583408954382536"
}
}
[11:49:14.389] Invocation finished in 3h0m59.096266595s with status FAILED