[20:53:34.519] New invocation is queued and will start shortly
[20:53:34.519] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[20:53:35.656] Starting the invocation (attempt 1)
[20:53:35.693] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:53:35.694] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:53:35.694] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9031952375695385472",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4291.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"ec6467ee-6946-486c-8f19-db124e05722c\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4291.0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9031952375695385472",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[20:53:36.158] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1602622415828896",
"id": "8866522313659049936",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4291.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ec6467ee-6946-486c-8f19-db124e05722c\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4291.0\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602622416034734",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9031952375695385472",
"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/8866522313659049936/+/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": "1602622416034851",
"url": "https://ci.chromium.org/b/8866522313659049936",
"utcnow_ts": "1602622416150168"
}
}
[20:53:36.158] Task URL: https://ci.chromium.org/b/8866522313659049936
[20:53:36.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:2:0) after 1m0s
[20:54:36.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:2:0)
[20:54:36.158] Timer tick, asking Buildbucket for the build status
[20:54:36.288] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:54:36.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:3:0) after 1m0s
[20:55:36.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:3:0)
[20:55:36.304] Timer tick, asking Buildbucket for the build status
[20:55:36.519] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:55:36.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:4:0) after 1m0s
[20:56:36.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:4:0)
[20:56:36.581] Timer tick, asking Buildbucket for the build status
[20:56:36.663] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:56:36.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:5:0) after 1m0s
[20:57:36.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:5:0)
[20:57:36.688] Timer tick, asking Buildbucket for the build status
[20:57:36.798] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:57:36.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:6:0) after 1m0s
[20:58:36.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:6:0)
[20:58:36.800] Timer tick, asking Buildbucket for the build status
[20:58:36.915] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:58:36.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:7:0) after 1m0s
[20:59:36.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:7:0)
[20:59:36.920] Timer tick, asking Buildbucket for the build status
[20:59:37.071] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:59:37.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:8:0) after 1m0s
[21:00:37.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:8:0)
[21:00:37.155] Timer tick, asking Buildbucket for the build status
[21:00:37.224] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:00:37.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:9:0) after 1m0s
[21:01:37.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:9:0)
[21:01:37.286] Timer tick, asking Buildbucket for the build status
[21:01:38.073] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:38.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:10:0) after 1m0s
[21:02:38.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:10:0)
[21:02:38.102] Timer tick, asking Buildbucket for the build status
[21:02:38.467] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:38.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:11:0) after 1m0s
[21:03:38.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:11:0)
[21:03:38.493] Timer tick, asking Buildbucket for the build status
[21:03:38.589] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:38.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:12:0) after 1m0s
[21:04:38.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:12:0)
[21:04:38.614] Timer tick, asking Buildbucket for the build status
[21:04:38.979] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:38.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:13:0) after 1m0s
[21:05:38.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:13:0)
[21:05:38.987] Timer tick, asking Buildbucket for the build status
[21:05:39.067] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:39.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:14:0) after 1m0s
[21:06:39.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:14:0)
[21:06:39.141] Timer tick, asking Buildbucket for the build status
[21:06:39.207] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:39.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:15:0) after 1m0s
[21:07:39.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:15:0)
[21:07:39.235] Timer tick, asking Buildbucket for the build status
[21:07:39.462] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:07:39.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:16:0) after 1m0s
[21:08:39.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:16:0)
[21:08:39.464] Timer tick, asking Buildbucket for the build status
[21:08:39.574] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:08:39.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:17:0) after 1m0s
[21:09:39.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:17:0)
[21:09:39.582] Timer tick, asking Buildbucket for the build status
[21:09:40.027] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:09:40.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:18:0) after 1m0s
[21:10:40.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:18:0)
[21:10:40.069] Timer tick, asking Buildbucket for the build status
[21:10:40.379] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:10:40.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:19:0) after 1m0s
[21:11:40.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:19:0)
[21:11:40.405] Timer tick, asking Buildbucket for the build status
[21:11:40.475] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:11:40.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:20:0) after 1m0s
[21:12:40.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:20:0)
[21:12:40.580] Timer tick, asking Buildbucket for the build status
[21:12:40.656] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:12:40.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:21:0) after 1m0s
[21:13:40.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:21:0)
[21:13:40.697] Timer tick, asking Buildbucket for the build status
[21:13:40.979] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:13:40.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:22:0) after 1m0s
[21:14:41.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:22:0)
[21:14:41.032] Timer tick, asking Buildbucket for the build status
[21:14:41.169] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:14:41.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:23:0) after 1m0s
[21:15:41.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:23:0)
[21:15:41.179] Timer tick, asking Buildbucket for the build status
[21:15:41.273] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:15:41.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:24:0) after 1m0s
[21:16:41.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:24:0)
[21:16:41.325] Timer tick, asking Buildbucket for the build status
[21:16:41.432] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:16:41.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:25:0) after 1m0s
[21:17:41.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:25:0)
[21:17:41.473] Timer tick, asking Buildbucket for the build status
[21:17:41.545] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:17:41.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:26:0) after 1m0s
[21:18:41.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:26:0)
[21:18:41.554] Timer tick, asking Buildbucket for the build status
[21:18:41.650] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:18:41.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:27:0) after 1m0s
[21:19:41.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:27:0)
[21:19:41.673] Timer tick, asking Buildbucket for the build status
[21:19:41.738] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:19:41.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:28:0) after 1m0s
[21:20:41.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:28:0)
[21:20:41.789] Timer tick, asking Buildbucket for the build status
[21:20:41.997] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:20:41.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:29:0) after 1m0s
[21:21:41.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:29:0)
[21:21:41.986] Timer tick, asking Buildbucket for the build status
[21:21:42.065] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:21:42.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:30:0) after 1m0s
[21:22:42.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:30:0)
[21:22:42.112] Timer tick, asking Buildbucket for the build status
[21:22:42.209] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:22:42.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:31:0) after 1m0s
[21:23:42.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:31:0)
[21:23:42.255] Timer tick, asking Buildbucket for the build status
[21:23:42.711] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:23:42.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:32:0) after 1m0s
[21:24:42.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:32:0)
[21:24:42.745] Timer tick, asking Buildbucket for the build status
[21:24:43.084] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:24:43.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:33:0) after 1m0s
[21:25:43.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:33:0)
[21:25:43.067] Timer tick, asking Buildbucket for the build status
[21:25:43.161] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:25:43.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:34:0) after 1m0s
[21:26:43.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:34:0)
[21:26:43.163] Timer tick, asking Buildbucket for the build status
[21:26:43.422] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:26:43.422] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:35:0) after 1m0s
[21:27:43.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:35:0)
[21:27:43.439] Timer tick, asking Buildbucket for the build status
[21:27:43.787] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:27:43.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:36:0) after 1m0s
[21:28:43.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:36:0)
[21:28:43.810] Timer tick, asking Buildbucket for the build status
[21:28:43.947] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:28:43.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:37:0) after 1m0s
[21:29:43.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:37:0)
[21:29:43.968] Timer tick, asking Buildbucket for the build status
[21:29:44.057] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:29:44.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:38:0) after 1m0s
[21:30:44.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:38:0)
[21:30:44.087] Timer tick, asking Buildbucket for the build status
[21:30:44.211] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:30:44.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:39:0) after 1m0s
[21:31:44.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:39:0)
[21:31:44.232] Timer tick, asking Buildbucket for the build status
[21:31:44.305] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:31:44.305] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:40:0) after 1m0s
[21:32:44.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:40:0)
[21:32:44.327] Timer tick, asking Buildbucket for the build status
[21:32:44.425] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:32:44.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:41:0) after 1m0s
[21:33:44.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:41:0)
[21:33:44.457] Timer tick, asking Buildbucket for the build status
[21:33:44.550] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:33:44.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:42:0) after 1m0s
[21:34:44.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:42:0)
[21:34:44.564] Timer tick, asking Buildbucket for the build status
[21:34:44.757] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:34:44.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:43:0) after 1m0s
[21:35:44.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:43:0)
[21:35:44.853] Timer tick, asking Buildbucket for the build status
[21:35:44.941] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:35:44.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:44:0) after 1m0s
[21:36:45.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:44:0)
[21:36:45.003] Timer tick, asking Buildbucket for the build status
[21:36:45.372] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:36:45.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:45:0) after 1m0s
[21:37:45.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:45:0)
[21:37:45.378] Timer tick, asking Buildbucket for the build status
[21:37:45.737] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:37:45.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:46:0) after 1m0s
[21:38:45.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:46:0)
[21:38:45.782] Timer tick, asking Buildbucket for the build status
[21:38:45.899] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:38:45.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:47:0) after 1m0s
[21:39:45.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:47:0)
[21:39:45.923] Timer tick, asking Buildbucket for the build status
[21:39:46.038] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:39:46.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:48:0) after 1m0s
[21:40:46.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:48:0)
[21:40:46.062] Timer tick, asking Buildbucket for the build status
[21:40:46.143] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:40:46.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:49:0) after 1m0s
[21:41:46.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:49:0)
[21:41:46.203] Timer tick, asking Buildbucket for the build status
[21:41:46.325] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:41:46.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:50:0) after 1m0s
[21:42:46.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:50:0)
[21:42:46.353] Timer tick, asking Buildbucket for the build status
[21:42:46.594] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:42:46.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:51:0) after 1m0s
[21:43:46.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:51:0)
[21:43:46.812] Timer tick, asking Buildbucket for the build status
[21:43:46.970] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:43:46.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:52:0) after 1m0s
[21:44:47.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:52:0)
[21:44:47.004] Timer tick, asking Buildbucket for the build status
[21:44:47.400] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:44:47.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:53:0) after 1m0s
[21:45:47.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:53:0)
[21:45:47.397] Timer tick, asking Buildbucket for the build status
[21:45:47.466] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:45:47.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:54:0) after 1m0s
[21:46:47.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:54:0)
[21:46:47.494] Timer tick, asking Buildbucket for the build status
[21:46:47.562] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:46:47.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:55:0) after 1m0s
[21:47:47.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:55:0)
[21:47:47.712] Timer tick, asking Buildbucket for the build status
[21:47:47.904] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:47:47.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:56:0) after 1m0s
[21:48:47.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:56:0)
[21:48:47.973] Timer tick, asking Buildbucket for the build status
[21:48:48.173] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:48:48.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:57:0) after 1m0s
[21:49:48.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:57:0)
[21:49:48.182] Timer tick, asking Buildbucket for the build status
[21:49:48.255] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:49:48.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:58:0) after 1m0s
[21:50:48.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:58:0)
[21:50:48.302] Timer tick, asking Buildbucket for the build status
[21:50:48.378] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:50:48.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:59:0) after 1m0s
[21:51:48.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:59:0)
[21:51:48.429] Timer tick, asking Buildbucket for the build status
[21:51:48.497] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:51:48.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:60:0) after 1m0s
[21:52:48.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:60:0)
[21:52:48.579] Timer tick, asking Buildbucket for the build status
[21:52:48.666] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:52:48.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:61:0) after 1m0s
[21:53:48.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:61:0)
[21:53:48.765] Timer tick, asking Buildbucket for the build status
[21:53:49.214] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:53:49.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:62:0) after 1m0s
[21:54:49.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:62:0)
[21:54:49.271] Timer tick, asking Buildbucket for the build status
[21:54:49.377] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:54:49.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:63:0) after 1m0s
[21:55:49.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:63:0)
[21:55:49.436] Timer tick, asking Buildbucket for the build status
[21:55:49.505] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:55:49.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:64:0) after 1m0s
[21:56:49.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:64:0)
[21:56:49.589] Timer tick, asking Buildbucket for the build status
[21:56:49.675] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:56:49.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:65:0) after 1m0s
[21:57:49.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:65:0)
[21:57:49.752] Timer tick, asking Buildbucket for the build status
[21:57:50.133] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:57:50.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:66:0) after 1m0s
[21:58:50.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:66:0)
[21:58:50.316] Timer tick, asking Buildbucket for the build status
[21:58:50.425] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:58:50.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:67:0) after 1m0s
[21:59:50.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:67:0)
[21:59:50.447] Timer tick, asking Buildbucket for the build status
[21:59:50.515] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:59:50.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:68:0) after 1m0s
[22:00:50.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:68:0)
[22:00:50.564] Timer tick, asking Buildbucket for the build status
[22:00:50.661] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:00:50.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:69:0) after 1m0s
[22:01:50.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:69:0)
[22:01:50.700] Timer tick, asking Buildbucket for the build status
[22:01:51.042] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:01:51.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:70:0) after 1m0s
[22:02:51.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:70:0)
[22:02:51.087] Timer tick, asking Buildbucket for the build status
[22:02:51.230] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:02:51.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:71:0) after 1m0s
[22:03:51.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:71:0)
[22:03:51.255] Timer tick, asking Buildbucket for the build status
[22:03:51.605] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:03:51.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:72:0) after 1m0s
[22:04:51.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:72:0)
[22:04:51.619] Timer tick, asking Buildbucket for the build status
[22:04:51.707] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:04:51.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:73:0) after 1m0s
[22:05:51.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:73:0)
[22:05:51.739] Timer tick, asking Buildbucket for the build status
[22:05:51.824] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:05:51.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:74:0) after 1m0s
[22:06:51.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:74:0)
[22:06:51.848] Timer tick, asking Buildbucket for the build status
[22:06:51.954] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:06:51.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:75:0) after 1m0s
[22:07:51.990] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:75:0)
[22:07:51.990] Timer tick, asking Buildbucket for the build status
[22:07:52.062] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:07:52.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:76:0) after 1m0s
[22:08:52.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:76:0)
[22:08:52.086] Timer tick, asking Buildbucket for the build status
[22:08:52.195] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:08:52.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:77:0) after 1m0s
[22:09:52.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:77:0)
[22:09:52.281] Timer tick, asking Buildbucket for the build status
[22:09:52.398] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:09:52.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:78:0) after 1m0s
[22:10:52.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:78:0)
[22:10:52.397] Timer tick, asking Buildbucket for the build status
[22:10:53.482] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:10:53.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:79:0) after 1m0s
[22:11:53.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:79:0)
[22:11:53.503] Timer tick, asking Buildbucket for the build status
[22:11:53.574] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:11:53.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:80:0) after 1m0s
[22:12:53.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:80:0)
[22:12:53.675] Timer tick, asking Buildbucket for the build status
[22:12:53.759] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:12:53.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:81:0) after 1m0s
[22:13:53.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:81:0)
[22:13:53.851] Timer tick, asking Buildbucket for the build status
[22:13:53.957] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:13:53.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:82:0) after 1m0s
[22:14:53.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:82:0)
[22:14:53.992] Timer tick, asking Buildbucket for the build status
[22:14:54.085] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:14:54.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:83:0) after 1m0s
[22:15:54.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:83:0)
[22:15:54.111] Timer tick, asking Buildbucket for the build status
[22:15:54.192] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:15:54.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:84:0) after 1m0s
[22:16:54.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:84:0)
[22:16:54.236] Timer tick, asking Buildbucket for the build status
[22:16:54.306] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:16:54.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:85:0) after 1m0s
[22:17:54.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:85:0)
[22:17:54.362] Timer tick, asking Buildbucket for the build status
[22:17:54.644] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:17:54.644] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:86:0) after 1m0s
[22:18:54.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:86:0)
[22:18:54.683] Timer tick, asking Buildbucket for the build status
[22:18:54.790] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:18:54.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:87:0) after 1m0s
[22:19:54.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:87:0)
[22:19:54.765] Timer tick, asking Buildbucket for the build status
[22:19:54.931] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:19:54.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:88:0) after 1m0s
[22:20:54.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:88:0)
[22:20:54.981] Timer tick, asking Buildbucket for the build status
[22:20:55.085] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:20:55.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:89:0) after 1m0s
[22:21:55.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:89:0)
[22:21:55.160] Timer tick, asking Buildbucket for the build status
[22:21:55.736] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:21:55.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:90:0) after 1m0s
[22:22:55.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:90:0)
[22:22:55.750] Timer tick, asking Buildbucket for the build status
[22:22:55.987] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:22:55.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:91:0) after 1m0s
[22:23:56.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:91:0)
[22:23:56.063] Timer tick, asking Buildbucket for the build status
[22:23:56.386] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:23:56.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:92:0) after 1m0s
[22:24:56.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:92:0)
[22:24:56.434] Timer tick, asking Buildbucket for the build status
[22:24:56.534] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:24:56.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:93:0) after 1m0s
[22:25:56.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:93:0)
[22:25:56.593] Timer tick, asking Buildbucket for the build status
[22:25:56.707] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:25:56.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:94:0) after 1m0s
[22:26:56.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:94:0)
[22:26:56.745] Timer tick, asking Buildbucket for the build status
[22:26:56.987] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:26:56.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:95:0) after 1m0s
[22:27:57.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:95:0)
[22:27:57.032] Timer tick, asking Buildbucket for the build status
[22:27:57.106] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:27:57.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:96:0) after 1m0s
[22:28:57.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:96:0)
[22:28:57.220] Timer tick, asking Buildbucket for the build status
[22:28:57.338] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:28:57.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:97:0) after 1m0s
[22:29:57.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:97:0)
[22:29:57.361] Timer tick, asking Buildbucket for the build status
[22:29:57.593] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:29:57.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:98:0) after 1m0s
[22:30:57.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:98:0)
[22:30:57.629] Timer tick, asking Buildbucket for the build status
[22:30:58.030] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:30:58.030] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:99:0) after 1m0s
[22:31:58.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:99:0)
[22:31:58.078] Timer tick, asking Buildbucket for the build status
[22:31:58.164] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:31:58.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:100:0) after 1m0s
[22:32:58.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:100:0)
[22:32:58.168] Timer tick, asking Buildbucket for the build status
[22:32:58.516] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:32:58.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:101:0) after 1m0s
[22:33:58.643] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:101:0)
[22:33:58.643] Timer tick, asking Buildbucket for the build status
[22:33:58.890] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:33:58.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:102:0) after 1m0s
[22:34:58.944] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:102:0)
[22:34:58.944] Timer tick, asking Buildbucket for the build status
[22:34:59.099] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:34:59.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:103:0) after 1m0s
[22:35:59.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:103:0)
[22:35:59.125] Timer tick, asking Buildbucket for the build status
[22:35:59.225] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:35:59.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:104:0) after 1m0s
[22:36:59.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:104:0)
[22:36:59.273] Timer tick, asking Buildbucket for the build status
[22:36:59.355] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:36:59.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:105:0) after 1m0s
[22:37:59.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:105:0)
[22:37:59.410] Timer tick, asking Buildbucket for the build status
[22:37:59.548] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:37:59.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:106:0) after 1m0s
[22:38:59.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:106:0)
[22:38:59.572] Timer tick, asking Buildbucket for the build status
[22:38:59.980] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:38:59.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:107:0) after 1m0s
[22:40:00.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:107:0)
[22:40:00.009] Timer tick, asking Buildbucket for the build status
[22:40:00.281] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:00.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:108:0) after 1m0s
[22:41:00.326] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:108:0)
[22:41:00.326] Timer tick, asking Buildbucket for the build status
[22:41:00.619] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:00.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:109:0) after 1m0s
[22:42:00.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:109:0)
[22:42:00.641] Timer tick, asking Buildbucket for the build status
[22:42:00.730] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:00.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:110:0) after 1m0s
[22:43:01.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:110:0)
[22:43:01.118] Timer tick, asking Buildbucket for the build status
[22:43:01.205] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:01.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:111:0) after 1m0s
[22:44:01.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:111:0)
[22:44:01.345] Timer tick, asking Buildbucket for the build status
[22:44:01.537] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:01.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:112:0) after 1m0s
[22:45:01.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:112:0)
[22:45:01.906] Timer tick, asking Buildbucket for the build status
[22:45:02.088] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:02.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:113:0) after 1m0s
[22:46:02.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:113:0)
[22:46:02.146] Timer tick, asking Buildbucket for the build status
[22:46:02.366] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:02.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:114:0) after 1m0s
[22:47:02.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:114:0)
[22:47:02.442] Timer tick, asking Buildbucket for the build status
[22:47:03.163] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:03.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:115:0) after 1m0s
[22:48:03.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:115:0)
[22:48:03.331] Timer tick, asking Buildbucket for the build status
[22:48:03.440] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:03.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:116:0) after 1m0s
[22:49:03.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:116:0)
[22:49:03.519] Timer tick, asking Buildbucket for the build status
[22:49:03.646] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:03.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:117:0) after 1m0s
[22:50:03.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:117:0)
[22:50:03.684] Timer tick, asking Buildbucket for the build status
[22:50:03.940] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:03.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:118:0) after 1m0s
[22:51:04.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:118:0)
[22:51:04.031] Timer tick, asking Buildbucket for the build status
[22:51:04.157] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:04.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:119:0) after 1m0s
[22:52:04.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:119:0)
[22:52:04.313] Timer tick, asking Buildbucket for the build status
[22:52:04.447] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:04.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:120:0) after 1m0s
[22:53:04.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:120:0)
[22:53:04.522] Timer tick, asking Buildbucket for the build status
[22:53:04.603] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:04.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:121:0) after 1m0s
[22:54:04.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:121:0)
[22:54:04.641] Timer tick, asking Buildbucket for the build status
[22:54:04.778] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:04.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:122:0) after 1m0s
[22:55:04.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:122:0)
[22:55:04.827] Timer tick, asking Buildbucket for the build status
[22:55:04.929] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:04.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:123:0) after 1m0s
[22:56:04.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:123:0)
[22:56:04.955] Timer tick, asking Buildbucket for the build status
[22:56:05.064] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:05.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:124:0) after 1m0s
[22:57:05.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:124:0)
[22:57:05.117] Timer tick, asking Buildbucket for the build status
[22:57:05.199] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:05.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:125:0) after 1m0s
[22:58:05.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:125:0)
[22:58:05.287] Timer tick, asking Buildbucket for the build status
[22:58:05.363] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:05.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:126:0) after 1m0s
[22:59:05.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:126:0)
[22:59:05.502] Timer tick, asking Buildbucket for the build status
[22:59:05.652] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:05.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:127:0) after 1m0s
[23:00:05.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:127:0)
[23:00:05.716] Timer tick, asking Buildbucket for the build status
[23:00:05.896] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:05.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:128:0) after 1m0s
[23:01:06.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:128:0)
[23:01:06.257] Timer tick, asking Buildbucket for the build status
[23:01:06.362] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:06.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:129:0) after 1m0s
[23:02:06.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:129:0)
[23:02:06.508] Timer tick, asking Buildbucket for the build status
[23:02:06.613] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:06.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:130:0) after 1m0s
[23:03:06.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:130:0)
[23:03:06.912] Timer tick, asking Buildbucket for the build status
[23:03:06.985] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:06.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:131:0) after 1m0s
[23:04:07.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:131:0)
[23:04:07.029] Timer tick, asking Buildbucket for the build status
[23:04:07.133] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:07.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:132:0) after 1m0s
[23:05:07.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:132:0)
[23:05:07.144] Timer tick, asking Buildbucket for the build status
[23:05:07.211] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:07.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:133:0) after 1m0s
[23:06:07.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:133:0)
[23:06:07.257] Timer tick, asking Buildbucket for the build status
[23:06:07.423] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:07.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:134:0) after 1m0s
[23:07:07.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:134:0)
[23:07:07.439] Timer tick, asking Buildbucket for the build status
[23:07:07.508] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:07.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:135:0) after 1m0s
[23:08:07.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:135:0)
[23:08:07.665] Timer tick, asking Buildbucket for the build status
[23:08:07.772] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:08:07.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:136:0) after 1m0s
[23:09:07.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:136:0)
[23:09:07.863] Timer tick, asking Buildbucket for the build status
[23:09:07.970] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:09:07.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:137:0) after 1m0s
[23:10:08.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:137:0)
[23:10:08.199] Timer tick, asking Buildbucket for the build status
[23:10:08.400] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:08.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:138:0) after 1m0s
[23:11:08.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:138:0)
[23:11:08.436] Timer tick, asking Buildbucket for the build status
[23:11:08.569] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:08.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:139:0) after 1m0s
[23:12:08.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:139:0)
[23:12:08.686] Timer tick, asking Buildbucket for the build status
[23:12:09.002] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:09.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:140:0) after 1m0s
[23:13:09.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:140:0)
[23:13:09.107] Timer tick, asking Buildbucket for the build status
[23:13:09.215] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:09.215] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:141:0) after 1m0s
[23:14:09.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:141:0)
[23:14:09.275] Timer tick, asking Buildbucket for the build status
[23:14:09.415] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:09.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:142:0) after 1m0s
[23:15:09.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:142:0)
[23:15:09.440] Timer tick, asking Buildbucket for the build status
[23:15:09.528] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:09.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:143:0) after 1m0s
[23:16:09.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:143:0)
[23:16:09.558] Timer tick, asking Buildbucket for the build status
[23:16:09.681] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:09.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:144:0) after 1m0s
[23:17:09.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:144:0)
[23:17:09.767] Timer tick, asking Buildbucket for the build status
[23:17:09.918] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:09.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:145:0) after 1m0s
[23:18:09.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:145:0)
[23:18:09.951] Timer tick, asking Buildbucket for the build status
[23:18:10.064] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:10.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:146:0) after 1m0s
[23:19:10.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:146:0)
[23:19:10.197] Timer tick, asking Buildbucket for the build status
[23:19:10.351] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:10.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:147:0) after 1m0s
[23:20:10.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:147:0)
[23:20:10.404] Timer tick, asking Buildbucket for the build status
[23:20:10.537] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:10.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:148:0) after 1m0s
[23:21:10.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:148:0)
[23:21:10.617] Timer tick, asking Buildbucket for the build status
[23:21:10.708] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:10.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:149:0) after 1m0s
[23:22:11.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:149:0)
[23:22:11.006] Timer tick, asking Buildbucket for the build status
[23:22:11.372] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:11.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:150:0) after 1m0s
[23:23:11.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:150:0)
[23:23:11.758] Timer tick, asking Buildbucket for the build status
[23:23:11.852] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:11.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:151:0) after 1m0s
[23:24:12.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:151:0)
[23:24:12.043] Timer tick, asking Buildbucket for the build status
[23:24:12.280] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:12.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:152:0) after 1m0s
[23:25:12.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:152:0)
[23:25:12.544] Timer tick, asking Buildbucket for the build status
[23:25:12.671] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:12.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:153:0) after 1m0s
[23:26:12.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:153:0)
[23:26:12.700] Timer tick, asking Buildbucket for the build status
[23:26:12.817] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:12.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:154:0) after 1m0s
[23:27:12.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:154:0)
[23:27:12.863] Timer tick, asking Buildbucket for the build status
[23:27:12.933] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:12.933] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:155:0) after 1m0s
[23:28:13.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:155:0)
[23:28:13.204] Timer tick, asking Buildbucket for the build status
[23:28:13.293] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:13.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:156:0) after 1m0s
[23:29:13.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:156:0)
[23:29:13.424] Timer tick, asking Buildbucket for the build status
[23:29:13.992] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:13.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:157:0) after 1m0s
[23:30:14.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:157:0)
[23:30:14.071] Timer tick, asking Buildbucket for the build status
[23:30:14.172] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:14.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:158:0) after 1m0s
[23:31:14.222] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:158:0)
[23:31:14.223] Timer tick, asking Buildbucket for the build status
[23:31:14.343] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:14.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:159:0) after 1m0s
[23:32:14.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:159:0)
[23:32:14.448] Timer tick, asking Buildbucket for the build status
[23:32:14.596] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:14.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:160:0) after 1m0s
[23:33:14.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:160:0)
[23:33:14.639] Timer tick, asking Buildbucket for the build status
[23:33:14.753] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:14.753] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:161:0) after 1m0s
[23:34:14.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:161:0)
[23:34:14.813] Timer tick, asking Buildbucket for the build status
[23:34:14.924] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:14.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:162:0) after 1m0s
[23:35:14.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:162:0)
[23:35:14.921] Timer tick, asking Buildbucket for the build status
[23:35:15.029] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:15.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:163:0) after 1m0s
[23:36:15.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:163:0)
[23:36:15.060] Timer tick, asking Buildbucket for the build status
[23:36:15.144] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:15.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:164:0) after 1m0s
[23:37:15.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:164:0)
[23:37:15.217] Timer tick, asking Buildbucket for the build status
[23:37:15.287] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:15.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:165:0) after 1m0s
[23:38:15.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:165:0)
[23:38:15.376] Timer tick, asking Buildbucket for the build status
[23:38:15.455] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:15.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:166:0) after 1m0s
[23:39:15.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:166:0)
[23:39:15.558] Timer tick, asking Buildbucket for the build status
[23:39:15.971] Build 8866522313659049936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:15.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:167:0) after 1m0s
[23:39:41.510] Received PubSub notification, asking Buildbucket for the build status
[23:39:41.580] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:15.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:167:0)
[23:40:15.971] Timer tick, asking Buildbucket for the build status
[23:40:16.979] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:16.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:169:0) after 1m0s
[23:41:16.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:169:0)
[23:41:16.993] Timer tick, asking Buildbucket for the build status
[23:41:17.071] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:17.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:170:0) after 1m0s
[23:42:17.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:170:0)
[23:42:17.138] Timer tick, asking Buildbucket for the build status
[23:42:17.418] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:17.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:171:0) after 1m0s
[23:43:17.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:171:0)
[23:43:17.438] Timer tick, asking Buildbucket for the build status
[23:43:17.515] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:17.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:172:0) after 1m0s
[23:44:17.509] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:172:0)
[23:44:17.509] Timer tick, asking Buildbucket for the build status
[23:44:17.779] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:17.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:173:0) after 1m0s
[23:45:17.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:173:0)
[23:45:17.840] Timer tick, asking Buildbucket for the build status
[23:45:17.906] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:17.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:174:0) after 1m0s
[23:46:17.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:174:0)
[23:46:17.959] Timer tick, asking Buildbucket for the build status
[23:46:18.555] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:18.555] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:175:0) after 1m0s
[23:47:19.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:175:0)
[23:47:19.006] Timer tick, asking Buildbucket for the build status
[23:47:19.087] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:19.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:176:0) after 1m0s
[23:48:19.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:176:0)
[23:48:19.333] Timer tick, asking Buildbucket for the build status
[23:48:19.383] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:19.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:177:0) after 1m0s
[23:49:19.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:177:0)
[23:49:19.426] Timer tick, asking Buildbucket for the build status
[23:49:19.546] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:19.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:178:0) after 1m0s
[23:50:19.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:178:0)
[23:50:19.712] Timer tick, asking Buildbucket for the build status
[23:50:19.779] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:19.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:179:0) after 1m0s
[23:51:19.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:179:0)
[23:51:19.938] Timer tick, asking Buildbucket for the build status
[23:51:19.995] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:19.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:180:0) after 1m0s
[23:52:20.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:180:0)
[23:52:20.112] Timer tick, asking Buildbucket for the build status
[23:52:20.162] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:20.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:181:0) after 1m0s
[23:53:20.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:181:0)
[23:53:20.281] Timer tick, asking Buildbucket for the build status
[23:53:20.345] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:20.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:182:0) after 1m0s
[23:54:20.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:182:0)
[23:54:20.394] Timer tick, asking Buildbucket for the build status
[23:54:20.517] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:20.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:183:0) after 1m0s
[23:55:20.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:183:0)
[23:55:20.671] Timer tick, asking Buildbucket for the build status
[23:55:20.765] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:20.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:184:0) after 1m0s
[23:56:20.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:184:0)
[23:56:20.835] Timer tick, asking Buildbucket for the build status
[23:56:20.901] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:20.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:185:0) after 1m0s
[23:57:20.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:185:0)
[23:57:20.970] Timer tick, asking Buildbucket for the build status
[23:57:21.213] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:21.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:186:0) after 1m0s
[23:58:21.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:186:0)
[23:58:21.381] Timer tick, asking Buildbucket for the build status
[23:58:21.469] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:21.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:187:0) after 1m0s
[23:59:21.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:187:0)
[23:59:21.535] Timer tick, asking Buildbucket for the build status
[23:59:21.818] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:21.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:188:0) after 1m0s
[00:00:21.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:188:0)
[00:00:21.887] Timer tick, asking Buildbucket for the build status
[00:00:21.947] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:21.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:189:0) after 1m0s
[00:01:22.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:189:0)
[00:01:22.077] Timer tick, asking Buildbucket for the build status
[00:01:22.157] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:22.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:190:0) after 1m0s
[00:02:22.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:190:0)
[00:02:22.257] Timer tick, asking Buildbucket for the build status
[00:02:22.335] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:22.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:191:0) after 1m0s
[00:03:22.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:191:0)
[00:03:22.385] Timer tick, asking Buildbucket for the build status
[00:03:22.460] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:22.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:192:0) after 1m0s
[00:04:22.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:192:0)
[00:04:22.602] Timer tick, asking Buildbucket for the build status
[00:04:22.688] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:22.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:193:0) after 1m0s
[00:05:22.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:193:0)
[00:05:22.724] Timer tick, asking Buildbucket for the build status
[00:05:23.986] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:23.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:194:0) after 1m0s
[00:06:24.050] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:194:0)
[00:06:24.050] Timer tick, asking Buildbucket for the build status
[00:06:24.199] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:24.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:195:0) after 1m0s
[00:07:24.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:195:0)
[00:07:24.320] Timer tick, asking Buildbucket for the build status
[00:07:24.418] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:24.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:196:0) after 1m0s
[00:08:24.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:196:0)
[00:08:24.430] Timer tick, asking Buildbucket for the build status
[00:08:24.505] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:24.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:197:0) after 1m0s
[00:09:24.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:197:0)
[00:09:24.532] Timer tick, asking Buildbucket for the build status
[00:09:24.661] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:24.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:198:0) after 1m0s
[00:10:24.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:198:0)
[00:10:24.761] Timer tick, asking Buildbucket for the build status
[00:10:24.827] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:24.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:199:0) after 1m0s
[00:11:24.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:199:0)
[00:11:24.889] Timer tick, asking Buildbucket for the build status
[00:11:25.033] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:25.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:200:0) after 1m0s
[00:12:25.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:200:0)
[00:12:25.124] Timer tick, asking Buildbucket for the build status
[00:12:25.255] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:25.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:201:0) after 1m0s
[00:13:25.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:201:0)
[00:13:25.273] Timer tick, asking Buildbucket for the build status
[00:13:25.334] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:25.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:202:0) after 1m0s
[00:14:25.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:202:0)
[00:14:25.482] Timer tick, asking Buildbucket for the build status
[00:14:25.569] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:25.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:203:0) after 1m0s
[00:15:25.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:203:0)
[00:15:25.611] Timer tick, asking Buildbucket for the build status
[00:15:25.671] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:25.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:204:0) after 1m0s
[00:16:25.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:204:0)
[00:16:25.703] Timer tick, asking Buildbucket for the build status
[00:16:25.759] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:25.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:205:0) after 1m0s
[00:17:25.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:205:0)
[00:17:25.823] Timer tick, asking Buildbucket for the build status
[00:17:25.881] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:25.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:206:0) after 1m0s
[00:18:25.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:206:0)
[00:18:25.913] Timer tick, asking Buildbucket for the build status
[00:18:26.006] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:26.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:207:0) after 1m0s
[00:19:26.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:207:0)
[00:19:26.147] Timer tick, asking Buildbucket for the build status
[00:19:26.265] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:26.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:208:0) after 1m0s
[00:20:26.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:208:0)
[00:20:26.344] Timer tick, asking Buildbucket for the build status
[00:20:26.433] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:26.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:209:0) after 1m0s
[00:21:26.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:209:0)
[00:21:26.485] Timer tick, asking Buildbucket for the build status
[00:21:26.553] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:26.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:210:0) after 1m0s
[00:22:26.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:210:0)
[00:22:26.673] Timer tick, asking Buildbucket for the build status
[00:22:26.833] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:26.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:211:0) after 1m0s
[00:23:26.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:211:0)
[00:23:26.899] Timer tick, asking Buildbucket for the build status
[00:23:26.976] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:26.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:212:0) after 1m0s
[00:24:27.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:212:0)
[00:24:27.033] Timer tick, asking Buildbucket for the build status
[00:24:27.127] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:27.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:213:0) after 1m0s
[00:25:27.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:213:0)
[00:25:27.157] Timer tick, asking Buildbucket for the build status
[00:25:27.302] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:27.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:214:0) after 1m0s
[00:26:27.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:214:0)
[00:26:27.340] Timer tick, asking Buildbucket for the build status
[00:26:27.419] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:27.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:215:0) after 1m0s
[00:27:27.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:215:0)
[00:27:27.494] Timer tick, asking Buildbucket for the build status
[00:27:27.785] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:27.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:216:0) after 1m0s
[00:28:27.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:216:0)
[00:28:27.825] Timer tick, asking Buildbucket for the build status
[00:28:28.083] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:28.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:217:0) after 1m0s
[00:29:28.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:217:0)
[00:29:28.155] Timer tick, asking Buildbucket for the build status
[00:29:28.312] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:28.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:218:0) after 1m0s
[00:30:28.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:218:0)
[00:30:28.357] Timer tick, asking Buildbucket for the build status
[00:30:28.417] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:28.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:219:0) after 1m0s
[00:31:28.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:219:0)
[00:31:28.508] Timer tick, asking Buildbucket for the build status
[00:31:28.612] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:28.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:220:0) after 1m0s
[00:32:28.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:220:0)
[00:32:28.675] Timer tick, asking Buildbucket for the build status
[00:32:28.811] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:28.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:221:0) after 1m0s
[00:33:28.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:221:0)
[00:33:28.914] Timer tick, asking Buildbucket for the build status
[00:33:28.978] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:28.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:222:0) after 1m0s
[00:34:29.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:222:0)
[00:34:29.134] Timer tick, asking Buildbucket for the build status
[00:34:29.243] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:29.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:223:0) after 1m0s
[00:35:29.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:223:0)
[00:35:29.313] Timer tick, asking Buildbucket for the build status
[00:35:29.463] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:29.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:224:0) after 1m0s
[00:36:29.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:224:0)
[00:36:29.507] Timer tick, asking Buildbucket for the build status
[00:36:29.578] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:29.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:225:0) after 1m0s
[00:37:29.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:225:0)
[00:37:29.707] Timer tick, asking Buildbucket for the build status
[00:37:29.767] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:29.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:226:0) after 1m0s
[00:38:29.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:226:0)
[00:38:29.832] Timer tick, asking Buildbucket for the build status
[00:38:29.902] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:29.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:227:0) after 1m0s
[00:39:29.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:227:0)
[00:39:29.955] Timer tick, asking Buildbucket for the build status
[00:39:30.063] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:30.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:228:0) after 1m0s
[00:40:30.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:228:0)
[00:40:30.105] Timer tick, asking Buildbucket for the build status
[00:40:30.692] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:30.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:229:0) after 1m0s
[00:41:30.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:229:0)
[00:41:30.708] Timer tick, asking Buildbucket for the build status
[00:41:31.025] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:31.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:230:0) after 1m0s
[00:42:31.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:230:0)
[00:42:31.065] Timer tick, asking Buildbucket for the build status
[00:42:31.206] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:31.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:231:0) after 1m0s
[00:43:31.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:231:0)
[00:43:31.238] Timer tick, asking Buildbucket for the build status
[00:43:31.317] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:31.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:232:0) after 1m0s
[00:44:31.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:232:0)
[00:44:31.407] Timer tick, asking Buildbucket for the build status
[00:44:31.508] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:31.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:233:0) after 1m0s
[00:45:31.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:233:0)
[00:45:31.592] Timer tick, asking Buildbucket for the build status
[00:45:31.654] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:31.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:234:0) after 1m0s
[00:46:31.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:234:0)
[00:46:31.670] Timer tick, asking Buildbucket for the build status
[00:46:31.911] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:31.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:235:0) after 1m0s
[00:47:31.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:235:0)
[00:47:31.962] Timer tick, asking Buildbucket for the build status
[00:47:32.326] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:32.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:236:0) after 1m0s
[00:48:32.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:236:0)
[00:48:32.362] Timer tick, asking Buildbucket for the build status
[00:48:32.537] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:32.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:237:0) after 1m0s
[00:49:32.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:237:0)
[00:49:32.528] Timer tick, asking Buildbucket for the build status
[00:49:32.637] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:32.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:238:0) after 1m0s
[00:50:32.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:238:0)
[00:50:32.737] Timer tick, asking Buildbucket for the build status
[00:50:32.825] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:32.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:239:0) after 1m0s
[00:51:32.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:239:0)
[00:51:32.851] Timer tick, asking Buildbucket for the build status
[00:51:32.935] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:32.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:240:0) after 1m0s
[00:52:33.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:240:0)
[00:52:33.054] Timer tick, asking Buildbucket for the build status
[00:52:33.127] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:33.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:241:0) after 1m0s
[00:53:33.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:241:0)
[00:53:33.162] Timer tick, asking Buildbucket for the build status
[00:53:33.241] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:33.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:242:0) after 1m0s
[00:54:33.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:242:0)
[00:54:33.275] Timer tick, asking Buildbucket for the build status
[00:54:33.437] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:33.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:243:0) after 1m0s
[00:55:33.491] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:243:0)
[00:55:33.491] Timer tick, asking Buildbucket for the build status
[00:55:33.560] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:33.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:244:0) after 1m0s
[00:56:33.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:244:0)
[00:56:33.611] Timer tick, asking Buildbucket for the build status
[00:56:33.803] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:33.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:245:0) after 1m0s
[00:57:33.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:245:0)
[00:57:33.858] Timer tick, asking Buildbucket for the build status
[00:57:34.996] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:34.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:246:0) after 1m0s
[00:58:35.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:246:0)
[00:58:35.037] Timer tick, asking Buildbucket for the build status
[00:58:35.086] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:35.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:247:0) after 1m0s
[00:59:35.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:247:0)
[00:59:35.086] Timer tick, asking Buildbucket for the build status
[00:59:35.187] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:35.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:248:0) after 1m0s
[01:00:35.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:248:0)
[01:00:35.278] Timer tick, asking Buildbucket for the build status
[01:00:35.386] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:35.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:249:0) after 1m0s
[01:01:35.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:249:0)
[01:01:35.526] Timer tick, asking Buildbucket for the build status
[01:01:35.596] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:35.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:250:0) after 1m0s
[01:02:35.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:250:0)
[01:02:35.693] Timer tick, asking Buildbucket for the build status
[01:02:36.058] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:36.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:251:0) after 1m0s
[01:03:36.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:251:0)
[01:03:36.157] Timer tick, asking Buildbucket for the build status
[01:03:36.227] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:36.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:252:0) after 1m0s
[01:04:36.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:252:0)
[01:04:36.233] Timer tick, asking Buildbucket for the build status
[01:04:36.390] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:36.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:253:0) after 1m0s
[01:05:36.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:253:0)
[01:05:36.520] Timer tick, asking Buildbucket for the build status
[01:05:36.586] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:36.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:254:0) after 1m0s
[01:06:36.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:254:0)
[01:06:36.708] Timer tick, asking Buildbucket for the build status
[01:06:36.770] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:36.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:255:0) after 1m0s
[01:07:36.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:255:0)
[01:07:36.813] Timer tick, asking Buildbucket for the build status
[01:07:36.897] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:36.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:256:0) after 1m0s
[01:08:37.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:256:0)
[01:08:37.024] Timer tick, asking Buildbucket for the build status
[01:08:37.116] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:37.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:257:0) after 1m0s
[01:09:37.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:257:0)
[01:09:37.148] Timer tick, asking Buildbucket for the build status
[01:09:37.302] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:37.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:258:0) after 1m0s
[01:10:37.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:258:0)
[01:10:37.344] Timer tick, asking Buildbucket for the build status
[01:10:37.573] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:37.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:259:0) after 1m0s
[01:11:37.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:259:0)
[01:11:37.701] Timer tick, asking Buildbucket for the build status
[01:11:38.459] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:38.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:260:0) after 1m0s
[01:12:38.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:260:0)
[01:12:38.510] Timer tick, asking Buildbucket for the build status
[01:12:38.570] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:38.570] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:261:0) after 1m0s
[01:13:38.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:261:0)
[01:13:38.625] Timer tick, asking Buildbucket for the build status
[01:13:38.743] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:38.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:262:0) after 1m0s
[01:14:38.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:262:0)
[01:14:38.809] Timer tick, asking Buildbucket for the build status
[01:14:39.197] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:39.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:263:0) after 1m0s
[01:15:39.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:263:0)
[01:15:39.238] Timer tick, asking Buildbucket for the build status
[01:15:39.317] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:39.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:264:0) after 1m0s
[01:16:39.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:264:0)
[01:16:39.397] Timer tick, asking Buildbucket for the build status
[01:16:39.686] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:39.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:265:0) after 1m0s
[01:17:39.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:265:0)
[01:17:39.822] Timer tick, asking Buildbucket for the build status
[01:17:39.895] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:39.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:266:0) after 1m0s
[01:18:40.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:266:0)
[01:18:40.039] Timer tick, asking Buildbucket for the build status
[01:18:40.269] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:40.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:267:0) after 1m0s
[01:19:40.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:267:0)
[01:19:40.327] Timer tick, asking Buildbucket for the build status
[01:19:40.522] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:40.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:268:0) after 1m0s
[01:20:40.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:268:0)
[01:20:40.528] Timer tick, asking Buildbucket for the build status
[01:20:40.657] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:40.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:269:0) after 1m0s
[01:21:40.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:269:0)
[01:21:40.699] Timer tick, asking Buildbucket for the build status
[01:21:40.799] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:40.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:270:0) after 1m0s
[01:22:40.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:270:0)
[01:22:40.927] Timer tick, asking Buildbucket for the build status
[01:22:41.060] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:41.060] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:271:0) after 1m0s
[01:23:41.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:271:0)
[01:23:41.108] Timer tick, asking Buildbucket for the build status
[01:23:41.293] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:41.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:272:0) after 1m0s
[01:24:41.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:272:0)
[01:24:41.394] Timer tick, asking Buildbucket for the build status
[01:24:41.545] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:41.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:273:0) after 1m0s
[01:25:41.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:273:0)
[01:25:41.582] Timer tick, asking Buildbucket for the build status
[01:25:41.655] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:41.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:274:0) after 1m0s
[01:26:41.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:274:0)
[01:26:41.729] Timer tick, asking Buildbucket for the build status
[01:26:41.835] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:41.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:275:0) after 1m0s
[01:27:41.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:275:0)
[01:27:41.881] Timer tick, asking Buildbucket for the build status
[01:27:41.955] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:41.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:276:0) after 1m0s
[01:28:42.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:276:0)
[01:28:42.024] Timer tick, asking Buildbucket for the build status
[01:28:42.101] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:42.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:277:0) after 1m0s
[01:29:42.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:277:0)
[01:29:42.108] Timer tick, asking Buildbucket for the build status
[01:29:42.241] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:42.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:278:0) after 1m0s
[01:30:42.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:278:0)
[01:30:42.295] Timer tick, asking Buildbucket for the build status
[01:30:42.360] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:42.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:279:0) after 1m0s
[01:31:42.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:279:0)
[01:31:42.474] Timer tick, asking Buildbucket for the build status
[01:31:42.596] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:42.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:280:0) after 1m0s
[01:32:42.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:280:0)
[01:32:42.684] Timer tick, asking Buildbucket for the build status
[01:32:43.109] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:43.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:281:0) after 1m0s
[01:33:43.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:281:0)
[01:33:43.185] Timer tick, asking Buildbucket for the build status
[01:33:43.249] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:43.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:282:0) after 1m0s
[01:34:43.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:282:0)
[01:34:43.279] Timer tick, asking Buildbucket for the build status
[01:34:43.418] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:43.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:283:0) after 1m0s
[01:35:43.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:283:0)
[01:35:43.496] Timer tick, asking Buildbucket for the build status
[01:35:43.623] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:43.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:284:0) after 1m0s
[01:36:43.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:284:0)
[01:36:43.724] Timer tick, asking Buildbucket for the build status
[01:36:43.809] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:43.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:285:0) after 1m0s
[01:37:43.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:285:0)
[01:37:43.898] Timer tick, asking Buildbucket for the build status
[01:37:44.235] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:44.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:286:0) after 1m0s
[01:38:44.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:286:0)
[01:38:44.345] Timer tick, asking Buildbucket for the build status
[01:38:44.509] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:44.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:287:0) after 1m0s
[01:39:44.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:287:0)
[01:39:44.546] Timer tick, asking Buildbucket for the build status
[01:39:44.706] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:44.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:288:0) after 1m0s
[01:40:44.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:288:0)
[01:40:44.828] Timer tick, asking Buildbucket for the build status
[01:40:44.909] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:44.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:289:0) after 1m0s
[01:41:44.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:289:0)
[01:41:44.962] Timer tick, asking Buildbucket for the build status
[01:41:45.102] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:45.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:290:0) after 1m0s
[01:42:45.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:290:0)
[01:42:45.145] Timer tick, asking Buildbucket for the build status
[01:42:45.208] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:45.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:291:0) after 1m0s
[01:43:45.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:291:0)
[01:43:45.285] Timer tick, asking Buildbucket for the build status
[01:43:45.385] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:45.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:292:0) after 1m0s
[01:44:45.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:292:0)
[01:44:45.468] Timer tick, asking Buildbucket for the build status
[01:44:45.656] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:45.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:293:0) after 1m0s
[01:45:45.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:293:0)
[01:45:45.708] Timer tick, asking Buildbucket for the build status
[01:45:45.764] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:45.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:294:0) after 1m0s
[01:46:45.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:294:0)
[01:46:45.756] Timer tick, asking Buildbucket for the build status
[01:46:45.823] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:45.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:295:0) after 1m0s
[01:47:45.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:295:0)
[01:47:45.857] Timer tick, asking Buildbucket for the build status
[01:47:45.920] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:45.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:296:0) after 1m0s
[01:48:46.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:296:0)
[01:48:46.021] Timer tick, asking Buildbucket for the build status
[01:48:46.097] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:46.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:297:0) after 1m0s
[01:49:46.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:297:0)
[01:49:46.182] Timer tick, asking Buildbucket for the build status
[01:49:46.288] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:46.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:298:0) after 1m0s
[01:50:46.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:298:0)
[01:50:46.329] Timer tick, asking Buildbucket for the build status
[01:50:46.414] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:46.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:299:0) after 1m0s
[01:51:47.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:299:0)
[01:51:47.625] Timer tick, asking Buildbucket for the build status
[01:51:47.676] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:47.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:300:0) after 1m0s
[01:52:48.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:300:0)
[01:52:48.193] Timer tick, asking Buildbucket for the build status
[01:52:48.263] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:48.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:301:0) after 1m0s
[01:53:48.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:301:0)
[01:53:48.499] Timer tick, asking Buildbucket for the build status
[01:53:48.623] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:48.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:302:0) after 1m0s
[01:54:48.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:302:0)
[01:54:48.777] Timer tick, asking Buildbucket for the build status
[01:54:49.274] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:49.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:303:0) after 1m0s
[01:55:49.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:303:0)
[01:55:49.505] Timer tick, asking Buildbucket for the build status
[01:55:49.567] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:49.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:304:0) after 1m0s
[01:56:49.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:304:0)
[01:56:49.934] Timer tick, asking Buildbucket for the build status
[01:56:50.272] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:50.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:305:0) after 1m0s
[01:57:50.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:305:0)
[01:57:50.465] Timer tick, asking Buildbucket for the build status
[01:57:50.546] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:50.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:306:0) after 1m0s
[01:58:50.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:306:0)
[01:58:50.768] Timer tick, asking Buildbucket for the build status
[01:58:50.914] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:50.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:307:0) after 1m0s
[01:59:51.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:307:0)
[01:59:51.109] Timer tick, asking Buildbucket for the build status
[01:59:51.224] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:51.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:308:0) after 1m0s
[02:00:51.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:308:0)
[02:00:51.307] Timer tick, asking Buildbucket for the build status
[02:00:51.383] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:51.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:309:0) after 1m0s
[02:01:51.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:309:0)
[02:01:51.413] Timer tick, asking Buildbucket for the build status
[02:01:51.551] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:51.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:310:0) after 1m0s
[02:02:51.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:310:0)
[02:02:51.656] Timer tick, asking Buildbucket for the build status
[02:02:52.031] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:52.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:311:0) after 1m0s
[02:03:52.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:311:0)
[02:03:52.231] Timer tick, asking Buildbucket for the build status
[02:03:52.297] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:52.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:312:0) after 1m0s
[02:04:52.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:312:0)
[02:04:52.439] Timer tick, asking Buildbucket for the build status
[02:04:52.575] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:52.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:313:0) after 1m0s
[02:05:52.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:313:0)
[02:05:52.650] Timer tick, asking Buildbucket for the build status
[02:05:52.721] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:52.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:314:0) after 1m0s
[02:06:52.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:314:0)
[02:06:52.803] Timer tick, asking Buildbucket for the build status
[02:06:53.365] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:53.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:315:0) after 1m0s
[02:07:53.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:315:0)
[02:07:53.430] Timer tick, asking Buildbucket for the build status
[02:07:53.616] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:53.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:316:0) after 1m0s
[02:08:53.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:316:0)
[02:08:53.728] Timer tick, asking Buildbucket for the build status
[02:08:53.793] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:53.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:317:0) after 1m0s
[02:09:53.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:317:0)
[02:09:53.780] Timer tick, asking Buildbucket for the build status
[02:09:54.388] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:54.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:318:0) after 1m0s
[02:10:54.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:318:0)
[02:10:54.457] Timer tick, asking Buildbucket for the build status
[02:10:54.527] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:54.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:319:0) after 1m0s
[02:11:54.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:319:0)
[02:11:54.596] Timer tick, asking Buildbucket for the build status
[02:11:54.710] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:54.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:320:0) after 1m0s
[02:12:54.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:320:0)
[02:12:54.754] Timer tick, asking Buildbucket for the build status
[02:12:54.855] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:54.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:321:0) after 1m0s
[02:13:54.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:321:0)
[02:13:54.915] Timer tick, asking Buildbucket for the build status
[02:13:55.286] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:55.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:322:0) after 1m0s
[02:14:55.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:322:0)
[02:14:55.278] Timer tick, asking Buildbucket for the build status
[02:14:55.332] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:55.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:323:0) after 1m0s
[02:15:55.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:323:0)
[02:15:55.411] Timer tick, asking Buildbucket for the build status
[02:15:55.497] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:55.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:324:0) after 1m0s
[02:16:55.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:324:0)
[02:16:55.639] Timer tick, asking Buildbucket for the build status
[02:16:55.700] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:55.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:325:0) after 1m0s
[02:17:55.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:325:0)
[02:17:55.924] Timer tick, asking Buildbucket for the build status
[02:17:56.086] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:56.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:326:0) after 1m0s
[02:18:56.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:326:0)
[02:18:56.288] Timer tick, asking Buildbucket for the build status
[02:18:56.476] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:56.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:327:0) after 1m0s
[02:19:56.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:327:0)
[02:19:56.541] Timer tick, asking Buildbucket for the build status
[02:19:56.653] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:56.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:328:0) after 1m0s
[02:20:56.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:328:0)
[02:20:56.802] Timer tick, asking Buildbucket for the build status
[02:20:56.870] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:56.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:329:0) after 1m0s
[02:21:56.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:329:0)
[02:21:56.999] Timer tick, asking Buildbucket for the build status
[02:21:57.061] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:57.061] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:330:0) after 1m0s
[02:22:57.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:330:0)
[02:22:57.095] Timer tick, asking Buildbucket for the build status
[02:22:57.183] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:57.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:331:0) after 1m0s
[02:23:57.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:331:0)
[02:23:57.291] Timer tick, asking Buildbucket for the build status
[02:24:01.037] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:01.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:332:0) after 1m0s
[02:25:01.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:332:0)
[02:25:01.837] Timer tick, asking Buildbucket for the build status
[02:25:01.911] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:01.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:333:0) after 1m0s
[02:26:02.040] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:333:0)
[02:26:02.040] Timer tick, asking Buildbucket for the build status
[02:26:02.113] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:02.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:334:0) after 1m0s
[02:27:02.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:334:0)
[02:27:02.169] Timer tick, asking Buildbucket for the build status
[02:27:02.224] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:02.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:335:0) after 1m0s
[02:28:02.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:335:0)
[02:28:02.258] Timer tick, asking Buildbucket for the build status
[02:28:02.402] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:02.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:336:0) after 1m0s
[02:29:02.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:336:0)
[02:29:02.604] Timer tick, asking Buildbucket for the build status
[02:29:02.767] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:02.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:337:0) after 1m0s
[02:30:02.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:337:0)
[02:30:02.867] Timer tick, asking Buildbucket for the build status
[02:30:04.282] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:04.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:338:0) after 1m0s
[02:31:04.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:338:0)
[02:31:04.385] Timer tick, asking Buildbucket for the build status
[02:31:04.629] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:04.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:339:0) after 1m0s
[02:32:04.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:339:0)
[02:32:04.685] Timer tick, asking Buildbucket for the build status
[02:32:04.755] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:04.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:340:0) after 1m0s
[02:33:04.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:340:0)
[02:33:04.793] Timer tick, asking Buildbucket for the build status
[02:33:05.028] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:05.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:341:0) after 1m0s
[02:34:05.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:341:0)
[02:34:05.059] Timer tick, asking Buildbucket for the build status
[02:34:05.164] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:05.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:342:0) after 1m0s
[02:35:05.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:342:0)
[02:35:05.169] Timer tick, asking Buildbucket for the build status
[02:35:05.258] Build 8866522313659049936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:05.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031952375695385472:343:0) after 1m0s
[02:35:34.867] Received PubSub notification, asking Buildbucket for the build status
[02:35:34.950] Build 8866522313659049936: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:35:34.950] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1602642934003353",
"created_by": "project:infra",
"created_ts": "1602622415828896",
"id": "8866522313659049936",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4291.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ec6467ee-6946-486c-8f19-db124e05722c\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4291.0\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_292036ca8cd0711903e829a3c5417e821d204af08fdef2e4b6d3affbee40eeb2_v2\", \"builder_4d1db109d30b9f0068cf0464722c703e05f788cd82e2d29876a9483818e7c333_v2\", \"git\", \"goma_v2\", \"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-dbqv\"], \"image\": [\"chrome-xenial-20101100-265b45aa9e2\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602632380793048",
"status": "COMPLETED",
"status_changed_ts": "1602642934450908",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9031952375695385472",
"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/8866522313659049936/+/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:4f3c8eede2634710",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1602642934464148",
"url": "https://ci.chromium.org/b/8866522313659049936",
"utcnow_ts": "1602642934942325"
}
}
[02:35:34.950] Invocation finished in 5h42m0.448176042s with status SUCCEEDED