[08:42:00.149] New invocation is queued and will start shortly
[08:42:00.149] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:42:01.322] Starting the invocation (attempt 1)
[08:42:01.364] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:42:01.364] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:42:01.364] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9050298989495479664",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"83.0.4095.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"ed29e958-7ec2-4d5d-88a8-683150e989d2\",\"title\":\"publish_tarball/0\"}]},\"version\":\"83.0.4095.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:9050298989495479664",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[08:42:02.113] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1585125721481387",
"id": "8884868927430508944",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4095.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ed29e958-7ec2-4d5d-88a8-683150e989d2\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4095.0\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585125721912614",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9050298989495479664",
"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/8884868927430508944/+/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": "1585125721912758",
"url": "https://ci.chromium.org/b/8884868927430508944",
"utcnow_ts": "1585125722103628"
}
}
[08:42:02.113] Task URL: https://ci.chromium.org/b/8884868927430508944
[08:42:02.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:2:0) after 1m0s
[08:43:02.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:2:0)
[08:43:02.145] Timer tick, asking Buildbucket for the build status
[08:43:02.325] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:43:02.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:3:0) after 1m0s
[08:44:02.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:3:0)
[08:44:02.352] Timer tick, asking Buildbucket for the build status
[08:44:02.512] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:44:02.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:4:0) after 1m0s
[08:45:02.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:4:0)
[08:45:02.668] Timer tick, asking Buildbucket for the build status
[08:45:03.077] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:45:03.077] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:5:0) after 1m0s
[08:46:03.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:5:0)
[08:46:03.168] Timer tick, asking Buildbucket for the build status
[08:46:03.306] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:46:03.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:6:0) after 1m0s
[08:47:03.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:6:0)
[08:47:03.361] Timer tick, asking Buildbucket for the build status
[08:47:03.459] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:47:03.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:7:0) after 1m0s
[08:48:03.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:7:0)
[08:48:03.540] Timer tick, asking Buildbucket for the build status
[08:48:03.669] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:48:03.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:8:0) after 1m0s
[08:49:03.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:8:0)
[08:49:03.733] Timer tick, asking Buildbucket for the build status
[08:49:03.894] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:49:03.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:9:0) after 1m0s
[08:50:03.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:9:0)
[08:50:03.915] Timer tick, asking Buildbucket for the build status
[08:50:04.052] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:50:04.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:10:0) after 1m0s
[08:51:04.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:10:0)
[08:51:04.153] Timer tick, asking Buildbucket for the build status
[08:51:04.265] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:51:04.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:11:0) after 1m0s
[08:52:04.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:11:0)
[08:52:04.317] Timer tick, asking Buildbucket for the build status
[08:52:04.391] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:52:04.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:12:0) after 1m0s
[08:53:04.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:12:0)
[08:53:04.411] Timer tick, asking Buildbucket for the build status
[08:53:04.737] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:53:04.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:13:0) after 1m0s
[08:54:04.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:13:0)
[08:54:04.909] Timer tick, asking Buildbucket for the build status
[08:54:05.102] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:54:05.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:14:0) after 1m0s
[08:55:05.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:14:0)
[08:55:05.223] Timer tick, asking Buildbucket for the build status
[08:55:05.309] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:55:05.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:15:0) after 1m0s
[08:56:05.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:15:0)
[08:56:05.420] Timer tick, asking Buildbucket for the build status
[08:56:05.713] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:56:05.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:16:0) after 1m0s
[08:57:05.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:16:0)
[08:57:05.748] Timer tick, asking Buildbucket for the build status
[08:57:05.938] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:57:05.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:17:0) after 1m0s
[08:58:06.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:17:0)
[08:58:06.076] Timer tick, asking Buildbucket for the build status
[08:58:06.178] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:58:06.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:18:0) after 1m0s
[08:59:06.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:18:0)
[08:59:06.155] Timer tick, asking Buildbucket for the build status
[08:59:06.461] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:59:06.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:19:0) after 1m0s
[09:00:06.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:19:0)
[09:00:06.646] Timer tick, asking Buildbucket for the build status
[09:00:06.792] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:00:06.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:20:0) after 1m0s
[09:01:06.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:20:0)
[09:01:06.891] Timer tick, asking Buildbucket for the build status
[09:01:07.129] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:01:07.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:21:0) after 1m0s
[09:02:07.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:21:0)
[09:02:07.246] Timer tick, asking Buildbucket for the build status
[09:02:07.330] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:02:07.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:22:0) after 1m0s
[09:03:07.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:22:0)
[09:03:07.333] Timer tick, asking Buildbucket for the build status
[09:03:07.426] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:03:07.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:23:0) after 1m0s
[09:04:07.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:23:0)
[09:04:07.477] Timer tick, asking Buildbucket for the build status
[09:04:07.699] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:04:07.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:24:0) after 1m0s
[09:05:07.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:24:0)
[09:05:07.769] Timer tick, asking Buildbucket for the build status
[09:05:07.909] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:05:07.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:25:0) after 1m0s
[09:06:07.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:25:0)
[09:06:07.964] Timer tick, asking Buildbucket for the build status
[09:06:08.081] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:06:08.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:26:0) after 1m0s
[09:07:08.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:26:0)
[09:07:08.153] Timer tick, asking Buildbucket for the build status
[09:07:08.366] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:07:08.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:27:0) after 1m0s
[09:08:08.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:27:0)
[09:08:08.464] Timer tick, asking Buildbucket for the build status
[09:08:08.637] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:08:08.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:28:0) after 1m0s
[09:09:08.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:28:0)
[09:09:08.723] Timer tick, asking Buildbucket for the build status
[09:09:08.846] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:09:08.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:29:0) after 1m0s
[09:10:08.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:29:0)
[09:10:08.853] Timer tick, asking Buildbucket for the build status
[09:10:08.989] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:10:08.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:30:0) after 1m0s
[09:11:09.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:30:0)
[09:11:09.041] Timer tick, asking Buildbucket for the build status
[09:11:09.202] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:11:09.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:31:0) after 1m0s
[09:12:09.944] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:31:0)
[09:12:09.944] Timer tick, asking Buildbucket for the build status
[09:12:10.080] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:12:10.080] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:32:0) after 1m0s
[09:13:10.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:32:0)
[09:13:10.195] Timer tick, asking Buildbucket for the build status
[09:13:10.315] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:13:10.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:33:0) after 1m0s
[09:14:10.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:33:0)
[09:14:10.330] Timer tick, asking Buildbucket for the build status
[09:14:10.634] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:14:10.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:34:0) after 1m0s
[09:15:10.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:34:0)
[09:15:10.708] Timer tick, asking Buildbucket for the build status
[09:15:10.813] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:15:10.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:35:0) after 1m0s
[09:16:10.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:35:0)
[09:16:10.938] Timer tick, asking Buildbucket for the build status
[09:16:11.204] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:16:11.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:36:0) after 1m0s
[09:17:11.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:36:0)
[09:17:11.275] Timer tick, asking Buildbucket for the build status
[09:17:11.663] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:17:11.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:37:0) after 1m0s
[09:18:11.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:37:0)
[09:18:11.745] Timer tick, asking Buildbucket for the build status
[09:18:11.845] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:18:11.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:38:0) after 1m0s
[09:19:11.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:38:0)
[09:19:11.864] Timer tick, asking Buildbucket for the build status
[09:19:11.989] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:19:11.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:39:0) after 1m0s
[09:20:12.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:39:0)
[09:20:12.056] Timer tick, asking Buildbucket for the build status
[09:20:12.303] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:20:12.303] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:40:0) after 1m0s
[09:21:12.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:40:0)
[09:21:12.317] Timer tick, asking Buildbucket for the build status
[09:21:12.599] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:21:12.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:41:0) after 1m0s
[09:22:12.663] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:41:0)
[09:22:12.663] Timer tick, asking Buildbucket for the build status
[09:22:12.976] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:22:12.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:42:0) after 1m0s
[09:23:13.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:42:0)
[09:23:13.094] Timer tick, asking Buildbucket for the build status
[09:23:13.481] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:23:13.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:43:0) after 1m0s
[09:24:13.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:43:0)
[09:24:13.533] Timer tick, asking Buildbucket for the build status
[09:24:13.930] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:24:13.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:44:0) after 1m0s
[09:25:13.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:44:0)
[09:25:13.968] Timer tick, asking Buildbucket for the build status
[09:25:14.772] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:25:14.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:45:0) after 1m0s
[09:26:14.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:45:0)
[09:26:14.887] Timer tick, asking Buildbucket for the build status
[09:26:14.969] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:26:14.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:46:0) after 1m0s
[09:27:15.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:46:0)
[09:27:15.025] Timer tick, asking Buildbucket for the build status
[09:27:15.393] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:27:15.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:47:0) after 1m0s
[09:28:15.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:47:0)
[09:28:15.447] Timer tick, asking Buildbucket for the build status
[09:28:15.863] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:28:15.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:48:0) after 1m0s
[09:29:15.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:48:0)
[09:29:15.886] Timer tick, asking Buildbucket for the build status
[09:29:16.055] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:29:16.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:49:0) after 1m0s
[09:30:16.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:49:0)
[09:30:16.110] Timer tick, asking Buildbucket for the build status
[09:30:16.363] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:30:16.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:50:0) after 1m0s
[09:31:16.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:50:0)
[09:31:16.432] Timer tick, asking Buildbucket for the build status
[09:31:16.583] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:31:16.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:51:0) after 1m0s
[09:32:16.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:51:0)
[09:32:16.664] Timer tick, asking Buildbucket for the build status
[09:32:17.378] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:32:17.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:52:0) after 1m0s
[09:33:17.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:52:0)
[09:33:17.418] Timer tick, asking Buildbucket for the build status
[09:33:17.627] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:33:17.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:53:0) after 1m0s
[09:34:17.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:53:0)
[09:34:17.613] Timer tick, asking Buildbucket for the build status
[09:34:17.761] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:34:17.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:54:0) after 1m0s
[09:35:17.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:54:0)
[09:35:17.856] Timer tick, asking Buildbucket for the build status
[09:35:18.161] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:35:18.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:55:0) after 1m0s
[09:36:18.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:55:0)
[09:36:18.253] Timer tick, asking Buildbucket for the build status
[09:36:18.401] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:36:18.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:56:0) after 1m0s
[09:37:18.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:56:0)
[09:37:18.423] Timer tick, asking Buildbucket for the build status
[09:37:18.553] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:37:18.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:57:0) after 1m0s
[09:38:18.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:57:0)
[09:38:18.575] Timer tick, asking Buildbucket for the build status
[09:38:18.698] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:38:18.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:58:0) after 1m0s
[09:39:18.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:58:0)
[09:39:18.734] Timer tick, asking Buildbucket for the build status
[09:39:18.854] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:39:18.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:59:0) after 1m0s
[09:40:18.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:59:0)
[09:40:18.901] Timer tick, asking Buildbucket for the build status
[09:40:19.073] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:40:19.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:60:0) after 1m0s
[09:41:19.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:60:0)
[09:41:19.095] Timer tick, asking Buildbucket for the build status
[09:41:19.217] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:41:19.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:61:0) after 1m0s
[09:42:19.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:61:0)
[09:42:19.244] Timer tick, asking Buildbucket for the build status
[09:42:19.494] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:42:19.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:62:0) after 1m0s
[09:43:19.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:62:0)
[09:43:19.517] Timer tick, asking Buildbucket for the build status
[09:43:19.641] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:43:19.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:63:0) after 1m0s
[09:44:19.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:63:0)
[09:44:19.694] Timer tick, asking Buildbucket for the build status
[09:44:20.856] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:44:20.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:64:0) after 1m0s
[09:45:20.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:64:0)
[09:45:20.885] Timer tick, asking Buildbucket for the build status
[09:45:20.997] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:45:20.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:65:0) after 1m0s
[09:46:21.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:65:0)
[09:46:21.094] Timer tick, asking Buildbucket for the build status
[09:46:21.224] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:46:21.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:66:0) after 1m0s
[09:47:21.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:66:0)
[09:47:21.291] Timer tick, asking Buildbucket for the build status
[09:47:21.607] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:47:21.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:67:0) after 1m0s
[09:48:21.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:67:0)
[09:48:21.642] Timer tick, asking Buildbucket for the build status
[09:48:21.890] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:48:21.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:68:0) after 1m0s
[09:49:21.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:68:0)
[09:49:21.942] Timer tick, asking Buildbucket for the build status
[09:49:22.665] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:49:22.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:69:0) after 1m0s
[09:50:22.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:69:0)
[09:50:22.787] Timer tick, asking Buildbucket for the build status
[09:50:23.038] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:50:23.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:70:0) after 1m0s
[09:51:23.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:70:0)
[09:51:23.065] Timer tick, asking Buildbucket for the build status
[09:51:23.394] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:51:23.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:71:0) after 1m0s
[09:52:23.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:71:0)
[09:52:23.417] Timer tick, asking Buildbucket for the build status
[09:52:23.618] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:52:23.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:72:0) after 1m0s
[09:53:23.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:72:0)
[09:53:23.695] Timer tick, asking Buildbucket for the build status
[09:53:23.803] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:53:23.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:73:0) after 1m0s
[09:54:23.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:73:0)
[09:54:23.787] Timer tick, asking Buildbucket for the build status
[09:54:24.045] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:54:24.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:74:0) after 1m0s
[09:55:24.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:74:0)
[09:55:24.205] Timer tick, asking Buildbucket for the build status
[09:55:24.342] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:55:24.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:75:0) after 1m0s
[09:56:24.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:75:0)
[09:56:24.368] Timer tick, asking Buildbucket for the build status
[09:56:24.671] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:56:24.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:76:0) after 1m0s
[09:57:24.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:76:0)
[09:57:24.692] Timer tick, asking Buildbucket for the build status
[09:57:24.841] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:57:24.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:77:0) after 1m0s
[09:58:24.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:77:0)
[09:58:24.902] Timer tick, asking Buildbucket for the build status
[09:58:25.111] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:58:25.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:78:0) after 1m0s
[09:59:25.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:78:0)
[09:59:25.125] Timer tick, asking Buildbucket for the build status
[09:59:25.275] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:59:25.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:79:0) after 1m0s
[10:00:25.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:79:0)
[10:00:25.361] Timer tick, asking Buildbucket for the build status
[10:00:25.652] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:00:25.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:80:0) after 1m0s
[10:01:25.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:80:0)
[10:01:25.779] Timer tick, asking Buildbucket for the build status
[10:01:25.963] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:01:25.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:81:0) after 1m0s
[10:02:26.010] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:81:0)
[10:02:26.010] Timer tick, asking Buildbucket for the build status
[10:02:26.195] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:02:26.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:82:0) after 1m0s
[10:03:26.207] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:82:0)
[10:03:26.207] Timer tick, asking Buildbucket for the build status
[10:03:26.312] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:03:26.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:83:0) after 1m0s
[10:04:26.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:83:0)
[10:04:26.348] Timer tick, asking Buildbucket for the build status
[10:04:26.526] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:04:26.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:84:0) after 1m0s
[10:05:26.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:84:0)
[10:05:26.526] Timer tick, asking Buildbucket for the build status
[10:05:26.732] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:05:26.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:85:0) after 1m0s
[10:06:26.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:85:0)
[10:06:26.790] Timer tick, asking Buildbucket for the build status
[10:06:26.940] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:06:26.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:86:0) after 1m0s
[10:07:27.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:86:0)
[10:07:27.013] Timer tick, asking Buildbucket for the build status
[10:07:27.138] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:07:27.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:87:0) after 1m0s
[10:08:27.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:87:0)
[10:08:27.193] Timer tick, asking Buildbucket for the build status
[10:08:27.284] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:08:27.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:88:0) after 1m0s
[10:09:27.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:88:0)
[10:09:27.415] Timer tick, asking Buildbucket for the build status
[10:09:27.889] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:09:27.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:89:0) after 1m0s
[10:10:27.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:89:0)
[10:10:27.987] Timer tick, asking Buildbucket for the build status
[10:10:28.137] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:10:28.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:90:0) after 1m0s
[10:11:28.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:90:0)
[10:11:28.151] Timer tick, asking Buildbucket for the build status
[10:11:28.294] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:11:28.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:91:0) after 1m0s
[10:12:28.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:91:0)
[10:12:28.316] Timer tick, asking Buildbucket for the build status
[10:12:28.622] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:12:28.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:92:0) after 1m0s
[10:13:28.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:92:0)
[10:13:28.698] Timer tick, asking Buildbucket for the build status
[10:13:29.342] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:13:29.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:93:0) after 1m0s
[10:14:29.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:93:0)
[10:14:29.408] Timer tick, asking Buildbucket for the build status
[10:14:30.390] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:14:30.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:94:0) after 1m0s
[10:15:30.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:94:0)
[10:15:30.446] Timer tick, asking Buildbucket for the build status
[10:15:30.566] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:15:30.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:95:0) after 1m0s
[10:16:30.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:95:0)
[10:16:30.626] Timer tick, asking Buildbucket for the build status
[10:16:30.692] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:16:30.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:96:0) after 1m0s
[10:17:30.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:96:0)
[10:17:30.711] Timer tick, asking Buildbucket for the build status
[10:17:30.829] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:17:30.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:97:0) after 1m0s
[10:18:30.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:97:0)
[10:18:30.860] Timer tick, asking Buildbucket for the build status
[10:18:30.958] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:18:30.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:98:0) after 1m0s
[10:19:30.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:98:0)
[10:19:30.989] Timer tick, asking Buildbucket for the build status
[10:19:31.215] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:19:31.215] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:99:0) after 1m0s
[10:20:31.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:99:0)
[10:20:31.244] Timer tick, asking Buildbucket for the build status
[10:20:31.424] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:20:31.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:100:0) after 1m0s
[10:21:31.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:100:0)
[10:21:31.458] Timer tick, asking Buildbucket for the build status
[10:21:31.569] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:21:31.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:101:0) after 1m0s
[10:22:31.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:101:0)
[10:22:31.610] Timer tick, asking Buildbucket for the build status
[10:22:31.678] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:22:31.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:102:0) after 1m0s
[10:23:31.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:102:0)
[10:23:31.696] Timer tick, asking Buildbucket for the build status
[10:23:32.031] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:23:32.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:103:0) after 1m0s
[10:24:32.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:103:0)
[10:24:32.085] Timer tick, asking Buildbucket for the build status
[10:24:32.891] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:24:32.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:104:0) after 1m0s
[10:25:32.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:104:0)
[10:25:32.946] Timer tick, asking Buildbucket for the build status
[10:25:33.036] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:25:33.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:105:0) after 1m0s
[10:26:33.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:105:0)
[10:26:33.053] Timer tick, asking Buildbucket for the build status
[10:26:33.145] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:26:33.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:106:0) after 1m0s
[10:27:33.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:106:0)
[10:27:33.234] Timer tick, asking Buildbucket for the build status
[10:27:33.328] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:27:33.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:107:0) after 1m0s
[10:28:33.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:107:0)
[10:28:33.317] Timer tick, asking Buildbucket for the build status
[10:28:33.462] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:28:33.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:108:0) after 1m0s
[10:29:33.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:108:0)
[10:29:33.506] Timer tick, asking Buildbucket for the build status
[10:29:34.029] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:29:34.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:109:0) after 1m0s
[10:30:34.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:109:0)
[10:30:34.057] Timer tick, asking Buildbucket for the build status
[10:30:34.290] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:30:34.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:110:0) after 1m0s
[10:31:34.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:110:0)
[10:31:34.322] Timer tick, asking Buildbucket for the build status
[10:31:34.440] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:31:34.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:111:0) after 1m0s
[10:32:34.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:111:0)
[10:32:34.464] Timer tick, asking Buildbucket for the build status
[10:32:34.650] Build 8884868927430508944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:32:34.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:112:0) after 1m0s
[10:33:13.268] Received PubSub notification, asking Buildbucket for the build status
[10:33:13.411] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:34.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:112:0)
[10:33:34.681] Timer tick, asking Buildbucket for the build status
[10:33:34.783] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:34.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:114:0) after 1m0s
[10:34:34.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:114:0)
[10:34:34.812] Timer tick, asking Buildbucket for the build status
[10:34:35.178] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:35.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:115:0) after 1m0s
[10:35:35.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:115:0)
[10:35:35.210] Timer tick, asking Buildbucket for the build status
[10:35:35.832] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:35.832] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:116:0) after 1m0s
[10:36:35.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:116:0)
[10:36:35.884] Timer tick, asking Buildbucket for the build status
[10:36:36.176] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:36.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:117:0) after 1m0s
[10:37:36.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:117:0)
[10:37:36.200] Timer tick, asking Buildbucket for the build status
[10:37:36.458] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:36.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:118:0) after 1m0s
[10:38:36.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:118:0)
[10:38:36.492] Timer tick, asking Buildbucket for the build status
[10:38:36.598] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:36.598] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:119:0) after 1m0s
[10:39:36.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:119:0)
[10:39:36.611] Timer tick, asking Buildbucket for the build status
[10:39:36.771] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:36.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:120:0) after 1m0s
[10:40:36.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:120:0)
[10:40:36.868] Timer tick, asking Buildbucket for the build status
[10:40:37.016] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:37.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:121:0) after 1m0s
[10:41:37.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:121:0)
[10:41:37.110] Timer tick, asking Buildbucket for the build status
[10:41:37.232] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:37.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:122:0) after 1m0s
[10:42:37.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:122:0)
[10:42:37.281] Timer tick, asking Buildbucket for the build status
[10:42:37.437] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:37.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:123:0) after 1m0s
[10:43:37.491] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:123:0)
[10:43:37.491] Timer tick, asking Buildbucket for the build status
[10:43:37.596] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:37.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:124:0) after 1m0s
[10:44:37.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:124:0)
[10:44:37.628] Timer tick, asking Buildbucket for the build status
[10:44:40.103] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:40.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:125:0) after 1m0s
[10:45:40.207] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:125:0)
[10:45:40.207] Timer tick, asking Buildbucket for the build status
[10:45:40.356] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:40.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:126:0) after 1m0s
[10:46:40.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:126:0)
[10:46:40.457] Timer tick, asking Buildbucket for the build status
[10:46:40.677] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:40.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:127:0) after 1m0s
[10:47:40.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:127:0)
[10:47:40.713] Timer tick, asking Buildbucket for the build status
[10:47:40.855] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:40.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:128:0) after 1m0s
[10:48:40.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:128:0)
[10:48:40.998] Timer tick, asking Buildbucket for the build status
[10:48:41.365] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:41.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:129:0) after 1m0s
[10:49:41.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:129:0)
[10:49:41.470] Timer tick, asking Buildbucket for the build status
[10:49:41.651] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:41.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:130:0) after 1m0s
[10:50:41.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:130:0)
[10:50:41.726] Timer tick, asking Buildbucket for the build status
[10:50:41.910] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:41.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:131:0) after 1m0s
[10:51:41.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:131:0)
[10:51:41.938] Timer tick, asking Buildbucket for the build status
[10:51:42.102] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:42.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:132:0) after 1m0s
[10:52:42.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:132:0)
[10:52:42.196] Timer tick, asking Buildbucket for the build status
[10:52:42.308] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:42.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:133:0) after 1m0s
[10:53:42.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:133:0)
[10:53:42.309] Timer tick, asking Buildbucket for the build status
[10:53:42.412] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:42.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:134:0) after 1m0s
[10:54:42.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:134:0)
[10:54:42.453] Timer tick, asking Buildbucket for the build status
[10:54:42.514] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:42.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:135:0) after 1m0s
[10:55:42.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:135:0)
[10:55:42.623] Timer tick, asking Buildbucket for the build status
[10:55:42.869] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:42.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:136:0) after 1m0s
[10:56:42.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:136:0)
[10:56:42.943] Timer tick, asking Buildbucket for the build status
[10:56:44.288] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:44.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:137:0) after 1m0s
[10:57:44.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:137:0)
[10:57:44.352] Timer tick, asking Buildbucket for the build status
[10:57:44.948] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:44.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:138:0) after 1m0s
[10:58:45.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:138:0)
[10:58:45.017] Timer tick, asking Buildbucket for the build status
[10:58:45.159] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:45.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:139:0) after 1m0s
[10:59:45.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:139:0)
[10:59:45.159] Timer tick, asking Buildbucket for the build status
[10:59:49.491] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:49.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:140:0) after 1m0s
[11:00:49.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:140:0)
[11:00:49.553] Timer tick, asking Buildbucket for the build status
[11:00:49.761] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:49.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:141:0) after 1m0s
[11:01:49.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:141:0)
[11:01:49.803] Timer tick, asking Buildbucket for the build status
[11:01:49.907] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:49.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:142:0) after 1m0s
[11:02:50.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:142:0)
[11:02:50.033] Timer tick, asking Buildbucket for the build status
[11:02:50.159] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:50.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:143:0) after 1m0s
[11:03:50.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:143:0)
[11:03:50.286] Timer tick, asking Buildbucket for the build status
[11:03:50.417] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:50.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:144:0) after 1m0s
[11:04:50.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:144:0)
[11:04:50.496] Timer tick, asking Buildbucket for the build status
[11:04:50.640] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:50.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:145:0) after 1m0s
[11:05:50.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:145:0)
[11:05:50.791] Timer tick, asking Buildbucket for the build status
[11:05:50.989] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:50.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:146:0) after 1m0s
[11:06:51.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:146:0)
[11:06:51.064] Timer tick, asking Buildbucket for the build status
[11:06:51.168] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:51.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:147:0) after 1m0s
[11:07:51.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:147:0)
[11:07:51.211] Timer tick, asking Buildbucket for the build status
[11:07:51.744] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:51.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:148:0) after 1m0s
[11:08:51.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:148:0)
[11:08:51.820] Timer tick, asking Buildbucket for the build status
[11:08:51.932] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:51.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:149:0) after 1m0s
[11:09:51.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:149:0)
[11:09:51.949] Timer tick, asking Buildbucket for the build status
[11:09:52.044] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:52.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:150:0) after 1m0s
[11:10:52.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:150:0)
[11:10:52.065] Timer tick, asking Buildbucket for the build status
[11:10:52.861] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:52.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:151:0) after 1m0s
[11:11:52.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:151:0)
[11:11:52.927] Timer tick, asking Buildbucket for the build status
[11:11:52.995] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:52.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:152:0) after 1m0s
[11:12:53.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:152:0)
[11:12:53.079] Timer tick, asking Buildbucket for the build status
[11:12:53.386] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:53.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:153:0) after 1m0s
[11:13:53.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:153:0)
[11:13:53.502] Timer tick, asking Buildbucket for the build status
[11:13:53.631] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:53.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:154:0) after 1m0s
[11:14:53.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:154:0)
[11:14:53.718] Timer tick, asking Buildbucket for the build status
[11:14:53.874] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:53.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:155:0) after 1m0s
[11:15:54.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:155:0)
[11:15:54.029] Timer tick, asking Buildbucket for the build status
[11:15:54.187] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:54.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:156:0) after 1m0s
[11:16:54.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:156:0)
[11:16:54.253] Timer tick, asking Buildbucket for the build status
[11:16:54.438] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:54.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:157:0) after 1m0s
[11:17:54.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:157:0)
[11:17:54.478] Timer tick, asking Buildbucket for the build status
[11:17:54.596] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:54.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:158:0) after 1m0s
[11:18:54.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:158:0)
[11:18:54.616] Timer tick, asking Buildbucket for the build status
[11:18:55.116] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:55.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:159:0) after 1m0s
[11:19:55.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:159:0)
[11:19:55.254] Timer tick, asking Buildbucket for the build status
[11:19:55.404] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:55.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:160:0) after 1m0s
[11:20:55.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:160:0)
[11:20:55.484] Timer tick, asking Buildbucket for the build status
[11:20:56.057] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:56.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:161:0) after 1m0s
[11:21:56.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:161:0)
[11:21:56.113] Timer tick, asking Buildbucket for the build status
[11:21:56.242] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:56.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:162:0) after 1m0s
[11:22:56.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:162:0)
[11:22:56.227] Timer tick, asking Buildbucket for the build status
[11:22:56.465] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:56.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:163:0) after 1m0s
[11:23:56.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:163:0)
[11:23:56.510] Timer tick, asking Buildbucket for the build status
[11:23:56.661] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:56.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:164:0) after 1m0s
[11:24:56.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:164:0)
[11:24:56.743] Timer tick, asking Buildbucket for the build status
[11:24:56.812] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:56.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:165:0) after 1m0s
[11:25:56.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:165:0)
[11:25:56.843] Timer tick, asking Buildbucket for the build status
[11:25:57.233] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:57.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:166:0) after 1m0s
[11:26:57.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:166:0)
[11:26:57.241] Timer tick, asking Buildbucket for the build status
[11:26:57.371] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:57.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:167:0) after 1m0s
[11:27:57.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:167:0)
[11:27:57.419] Timer tick, asking Buildbucket for the build status
[11:27:57.569] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:57.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:168:0) after 1m0s
[11:28:57.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:168:0)
[11:28:57.660] Timer tick, asking Buildbucket for the build status
[11:28:57.875] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:57.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:169:0) after 1m0s
[11:29:58.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:169:0)
[11:29:58.020] Timer tick, asking Buildbucket for the build status
[11:29:58.670] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:58.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:170:0) after 1m0s
[11:30:58.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:170:0)
[11:30:58.712] Timer tick, asking Buildbucket for the build status
[11:30:59.669] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:59.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:171:0) after 1m0s
[11:31:59.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:171:0)
[11:31:59.648] Timer tick, asking Buildbucket for the build status
[11:31:59.850] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:59.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:172:0) after 1m0s
[11:32:59.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:172:0)
[11:32:59.919] Timer tick, asking Buildbucket for the build status
[11:33:00.117] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:00.117] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:173:0) after 1m0s
[11:34:00.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:173:0)
[11:34:00.107] Timer tick, asking Buildbucket for the build status
[11:34:00.249] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:00.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:174:0) after 1m0s
[11:35:00.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:174:0)
[11:35:00.377] Timer tick, asking Buildbucket for the build status
[11:35:00.585] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:00.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:175:0) after 1m0s
[11:36:00.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:175:0)
[11:36:00.675] Timer tick, asking Buildbucket for the build status
[11:36:00.809] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:00.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:176:0) after 1m0s
[11:37:00.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:176:0)
[11:37:00.897] Timer tick, asking Buildbucket for the build status
[11:37:00.997] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:00.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:177:0) after 1m0s
[11:38:01.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:177:0)
[11:38:01.074] Timer tick, asking Buildbucket for the build status
[11:38:01.420] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:01.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:178:0) after 1m0s
[11:39:01.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:178:0)
[11:39:01.480] Timer tick, asking Buildbucket for the build status
[11:39:02.031] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:02.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:179:0) after 1m0s
[11:40:02.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:179:0)
[11:40:02.045] Timer tick, asking Buildbucket for the build status
[11:40:02.177] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:02.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:180:0) after 1m0s
[11:41:02.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:180:0)
[11:41:02.208] Timer tick, asking Buildbucket for the build status
[11:41:02.374] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:02.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:181:0) after 1m0s
[11:42:02.399] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:181:0)
[11:42:02.399] Timer tick, asking Buildbucket for the build status
[11:42:02.528] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:02.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:182:0) after 1m0s
[11:43:02.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:182:0)
[11:43:02.662] Timer tick, asking Buildbucket for the build status
[11:43:02.791] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:02.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:183:0) after 1m0s
[11:44:02.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:183:0)
[11:44:02.898] Timer tick, asking Buildbucket for the build status
[11:44:03.039] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:03.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:184:0) after 1m0s
[11:45:03.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:184:0)
[11:45:03.189] Timer tick, asking Buildbucket for the build status
[11:45:03.259] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:03.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:185:0) after 1m0s
[11:46:03.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:185:0)
[11:46:03.306] Timer tick, asking Buildbucket for the build status
[11:46:03.494] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:03.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:186:0) after 1m0s
[11:47:03.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:186:0)
[11:47:03.761] Timer tick, asking Buildbucket for the build status
[11:47:03.959] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:03.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:187:0) after 1m0s
[11:48:04.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:187:0)
[11:48:04.134] Timer tick, asking Buildbucket for the build status
[11:48:04.332] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:04.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:188:0) after 1m0s
[11:49:04.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:188:0)
[11:49:04.330] Timer tick, asking Buildbucket for the build status
[11:49:04.497] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:04.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:189:0) after 1m0s
[11:50:04.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:189:0)
[11:50:04.541] Timer tick, asking Buildbucket for the build status
[11:50:04.764] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:04.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:190:0) after 1m0s
[11:51:04.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:190:0)
[11:51:04.835] Timer tick, asking Buildbucket for the build status
[11:51:05.037] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:05.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:191:0) after 1m0s
[11:52:05.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:191:0)
[11:52:05.135] Timer tick, asking Buildbucket for the build status
[11:52:05.385] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:05.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:192:0) after 1m0s
[11:53:05.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:192:0)
[11:53:05.518] Timer tick, asking Buildbucket for the build status
[11:53:05.844] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:05.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:193:0) after 1m0s
[11:54:05.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:193:0)
[11:54:05.873] Timer tick, asking Buildbucket for the build status
[11:54:05.990] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:05.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:194:0) after 1m0s
[11:55:06.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:194:0)
[11:55:06.145] Timer tick, asking Buildbucket for the build status
[11:55:06.550] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:06.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:195:0) after 1m0s
[11:56:06.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:195:0)
[11:56:06.635] Timer tick, asking Buildbucket for the build status
[11:56:06.806] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:06.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:196:0) after 1m0s
[11:57:06.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:196:0)
[11:57:06.878] Timer tick, asking Buildbucket for the build status
[11:57:07.165] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:07.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:197:0) after 1m0s
[11:58:07.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:197:0)
[11:58:07.282] Timer tick, asking Buildbucket for the build status
[11:58:07.552] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:07.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:198:0) after 1m0s
[11:59:07.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:198:0)
[11:59:07.653] Timer tick, asking Buildbucket for the build status
[11:59:07.870] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:07.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:199:0) after 1m0s
[12:00:07.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:199:0)
[12:00:07.932] Timer tick, asking Buildbucket for the build status
[12:00:08.090] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:08.090] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:200:0) after 1m0s
[12:01:08.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:200:0)
[12:01:08.134] Timer tick, asking Buildbucket for the build status
[12:01:08.246] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:08.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:201:0) after 1m0s
[12:02:08.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:201:0)
[12:02:08.276] Timer tick, asking Buildbucket for the build status
[12:02:08.492] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:08.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:202:0) after 1m0s
[12:03:08.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:202:0)
[12:03:08.473] Timer tick, asking Buildbucket for the build status
[12:03:08.601] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:08.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:203:0) after 1m0s
[12:04:08.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:203:0)
[12:04:08.737] Timer tick, asking Buildbucket for the build status
[12:04:08.867] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:08.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:204:0) after 1m0s
[12:05:09.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:204:0)
[12:05:09.440] Timer tick, asking Buildbucket for the build status
[12:05:09.669] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:09.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:205:0) after 1m0s
[12:06:09.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:205:0)
[12:06:09.698] Timer tick, asking Buildbucket for the build status
[12:06:09.971] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:09.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:206:0) after 1m0s
[12:07:10.130] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:206:0)
[12:07:10.130] Timer tick, asking Buildbucket for the build status
[12:07:10.545] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:10.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:207:0) after 1m0s
[12:08:10.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:207:0)
[12:08:10.688] Timer tick, asking Buildbucket for the build status
[12:08:11.084] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:11.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:208:0) after 1m0s
[12:09:11.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:208:0)
[12:09:11.194] Timer tick, asking Buildbucket for the build status
[12:09:11.306] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:11.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:209:0) after 1m0s
[12:10:11.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:209:0)
[12:10:11.380] Timer tick, asking Buildbucket for the build status
[12:10:12.054] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:12.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:210:0) after 1m0s
[12:11:12.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:210:0)
[12:11:12.145] Timer tick, asking Buildbucket for the build status
[12:11:12.216] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:12.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:211:0) after 1m0s
[12:12:12.269] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:211:0)
[12:12:12.269] Timer tick, asking Buildbucket for the build status
[12:12:12.614] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:12.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:212:0) after 1m0s
[12:13:12.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:212:0)
[12:13:12.710] Timer tick, asking Buildbucket for the build status
[12:13:12.860] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:12.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:213:0) after 1m0s
[12:14:12.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:213:0)
[12:14:12.950] Timer tick, asking Buildbucket for the build status
[12:14:13.348] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:13.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:214:0) after 1m0s
[12:15:13.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:214:0)
[12:15:13.393] Timer tick, asking Buildbucket for the build status
[12:15:13.571] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:13.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:215:0) after 1m0s
[12:16:13.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:215:0)
[12:16:13.632] Timer tick, asking Buildbucket for the build status
[12:16:13.757] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:13.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:216:0) after 1m0s
[12:17:13.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:216:0)
[12:17:13.813] Timer tick, asking Buildbucket for the build status
[12:17:14.178] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:14.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:217:0) after 1m0s
[12:18:14.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:217:0)
[12:18:14.345] Timer tick, asking Buildbucket for the build status
[12:18:14.504] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:14.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:218:0) after 1m0s
[12:19:14.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:218:0)
[12:19:14.651] Timer tick, asking Buildbucket for the build status
[12:19:14.729] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:14.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:219:0) after 1m0s
[12:20:14.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:219:0)
[12:20:14.836] Timer tick, asking Buildbucket for the build status
[12:20:15.025] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:15.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:220:0) after 1m0s
[12:21:15.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:220:0)
[12:21:15.129] Timer tick, asking Buildbucket for the build status
[12:21:15.283] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:15.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:221:0) after 1m0s
[12:22:15.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:221:0)
[12:22:15.432] Timer tick, asking Buildbucket for the build status
[12:22:15.577] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:15.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:222:0) after 1m0s
[12:23:15.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:222:0)
[12:23:15.613] Timer tick, asking Buildbucket for the build status
[12:23:15.817] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:15.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:223:0) after 1m0s
[12:24:15.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:223:0)
[12:24:15.908] Timer tick, asking Buildbucket for the build status
[12:24:16.040] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:16.040] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:224:0) after 1m0s
[12:25:16.090] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:224:0)
[12:25:16.090] Timer tick, asking Buildbucket for the build status
[12:25:16.542] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:16.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:225:0) after 1m0s
[12:26:16.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:225:0)
[12:26:16.785] Timer tick, asking Buildbucket for the build status
[12:26:17.218] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:17.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:226:0) after 1m0s
[12:27:17.300] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:226:0)
[12:27:17.300] Timer tick, asking Buildbucket for the build status
[12:27:17.368] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:17.368] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:227:0) after 1m0s
[12:28:17.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:227:0)
[12:28:17.492] Timer tick, asking Buildbucket for the build status
[12:28:17.651] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:17.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:228:0) after 1m0s
[12:29:17.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:228:0)
[12:29:17.749] Timer tick, asking Buildbucket for the build status
[12:29:18.167] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:18.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:229:0) after 1m0s
[12:30:18.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:229:0)
[12:30:18.278] Timer tick, asking Buildbucket for the build status
[12:30:18.382] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:18.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:230:0) after 1m0s
[12:31:18.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:230:0)
[12:31:18.419] Timer tick, asking Buildbucket for the build status
[12:31:18.736] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:18.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:231:0) after 1m0s
[12:32:18.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:231:0)
[12:32:18.805] Timer tick, asking Buildbucket for the build status
[12:32:18.896] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:18.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:232:0) after 1m0s
[12:33:19.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:232:0)
[12:33:19.038] Timer tick, asking Buildbucket for the build status
[12:33:19.158] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:19.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:233:0) after 1m0s
[12:34:19.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:233:0)
[12:34:19.235] Timer tick, asking Buildbucket for the build status
[12:34:19.342] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:19.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:234:0) after 1m0s
[12:35:19.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:234:0)
[12:35:19.350] Timer tick, asking Buildbucket for the build status
[12:35:19.619] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:19.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:235:0) after 1m0s
[12:36:19.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:235:0)
[12:36:19.699] Timer tick, asking Buildbucket for the build status
[12:36:19.810] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:19.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:236:0) after 1m0s
[12:37:19.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:236:0)
[12:37:19.874] Timer tick, asking Buildbucket for the build status
[12:37:20.118] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:20.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:237:0) after 1m0s
[12:38:20.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:237:0)
[12:38:20.298] Timer tick, asking Buildbucket for the build status
[12:38:20.403] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:20.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:238:0) after 1m0s
[12:39:20.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:238:0)
[12:39:20.577] Timer tick, asking Buildbucket for the build status
[12:39:21.000] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:21.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:239:0) after 1m0s
[12:40:21.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:239:0)
[12:40:21.038] Timer tick, asking Buildbucket for the build status
[12:40:21.285] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:21.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:240:0) after 1m0s
[12:41:21.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:240:0)
[12:41:21.406] Timer tick, asking Buildbucket for the build status
[12:41:21.638] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:21.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:241:0) after 1m0s
[12:42:21.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:241:0)
[12:42:21.683] Timer tick, asking Buildbucket for the build status
[12:42:21.786] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:21.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:242:0) after 1m0s
[12:43:21.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:242:0)
[12:43:21.872] Timer tick, asking Buildbucket for the build status
[12:43:22.191] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:22.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:243:0) after 1m0s
[12:44:22.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:243:0)
[12:44:22.249] Timer tick, asking Buildbucket for the build status
[12:44:22.686] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:22.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:244:0) after 1m0s
[12:45:22.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:244:0)
[12:45:22.713] Timer tick, asking Buildbucket for the build status
[12:45:22.942] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:22.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:245:0) after 1m0s
[12:46:23.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:245:0)
[12:46:23.017] Timer tick, asking Buildbucket for the build status
[12:46:23.308] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:23.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:246:0) after 1m0s
[12:47:23.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:246:0)
[12:47:23.327] Timer tick, asking Buildbucket for the build status
[12:47:23.494] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:23.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:247:0) after 1m0s
[12:48:23.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:247:0)
[12:48:23.508] Timer tick, asking Buildbucket for the build status
[12:48:23.640] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:23.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:248:0) after 1m0s
[12:49:23.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:248:0)
[12:49:23.724] Timer tick, asking Buildbucket for the build status
[12:49:23.852] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:23.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:249:0) after 1m0s
[12:50:23.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:249:0)
[12:50:23.885] Timer tick, asking Buildbucket for the build status
[12:50:24.141] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:24.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:250:0) after 1m0s
[12:51:24.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:250:0)
[12:51:24.235] Timer tick, asking Buildbucket for the build status
[12:51:25.162] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:25.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:251:0) after 1m0s
[12:52:25.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:251:0)
[12:52:25.309] Timer tick, asking Buildbucket for the build status
[12:52:25.516] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:25.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:252:0) after 1m0s
[12:53:25.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:252:0)
[12:53:25.548] Timer tick, asking Buildbucket for the build status
[12:53:26.051] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:26.051] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:253:0) after 1m0s
[12:54:26.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:253:0)
[12:54:26.074] Timer tick, asking Buildbucket for the build status
[12:54:26.470] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:26.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:254:0) after 1m0s
[12:55:26.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:254:0)
[12:55:26.528] Timer tick, asking Buildbucket for the build status
[12:55:26.657] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:26.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:255:0) after 1m0s
[12:56:26.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:255:0)
[12:56:26.707] Timer tick, asking Buildbucket for the build status
[12:56:26.773] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:26.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:256:0) after 1m0s
[12:57:26.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:256:0)
[12:57:26.819] Timer tick, asking Buildbucket for the build status
[12:57:26.977] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:26.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:257:0) after 1m0s
[12:58:27.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:257:0)
[12:58:27.065] Timer tick, asking Buildbucket for the build status
[12:58:27.308] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:27.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:258:0) after 1m0s
[12:59:27.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:258:0)
[12:59:27.336] Timer tick, asking Buildbucket for the build status
[12:59:27.457] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:27.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:259:0) after 1m0s
[13:00:27.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:259:0)
[13:00:27.498] Timer tick, asking Buildbucket for the build status
[13:00:27.766] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:27.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:260:0) after 1m0s
[13:01:27.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:260:0)
[13:01:27.796] Timer tick, asking Buildbucket for the build status
[13:01:27.961] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:27.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:261:0) after 1m0s
[13:02:27.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:261:0)
[13:02:27.970] Timer tick, asking Buildbucket for the build status
[13:02:28.101] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:28.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:262:0) after 1m0s
[13:03:28.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:262:0)
[13:03:28.183] Timer tick, asking Buildbucket for the build status
[13:03:28.302] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:28.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:263:0) after 1m0s
[13:04:28.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:263:0)
[13:04:28.377] Timer tick, asking Buildbucket for the build status
[13:04:28.445] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:28.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:264:0) after 1m0s
[13:05:28.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:264:0)
[13:05:28.530] Timer tick, asking Buildbucket for the build status
[13:05:28.710] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:28.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:265:0) after 1m0s
[13:06:28.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:265:0)
[13:06:28.778] Timer tick, asking Buildbucket for the build status
[13:06:29.253] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:29.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:266:0) after 1m0s
[13:07:29.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:266:0)
[13:07:29.296] Timer tick, asking Buildbucket for the build status
[13:07:29.457] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:29.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:267:0) after 1m0s
[13:08:29.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:267:0)
[13:08:29.489] Timer tick, asking Buildbucket for the build status
[13:08:29.692] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:29.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:268:0) after 1m0s
[13:09:29.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:268:0)
[13:09:29.709] Timer tick, asking Buildbucket for the build status
[13:09:30.061] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:30.061] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:269:0) after 1m0s
[13:10:30.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:269:0)
[13:10:30.107] Timer tick, asking Buildbucket for the build status
[13:10:30.251] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:30.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:270:0) after 1m0s
[13:11:30.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:270:0)
[13:11:30.371] Timer tick, asking Buildbucket for the build status
[13:11:30.596] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:30.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:271:0) after 1m0s
[13:12:30.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:271:0)
[13:12:30.595] Timer tick, asking Buildbucket for the build status
[13:12:30.814] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:30.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:272:0) after 1m0s
[13:13:30.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:272:0)
[13:13:30.895] Timer tick, asking Buildbucket for the build status
[13:13:31.034] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:31.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:273:0) after 1m0s
[13:14:31.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:273:0)
[13:14:31.043] Timer tick, asking Buildbucket for the build status
[13:14:31.143] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:31.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:274:0) after 1m0s
[13:15:31.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:274:0)
[13:15:31.187] Timer tick, asking Buildbucket for the build status
[13:15:31.339] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:31.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:275:0) after 1m0s
[13:16:31.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:275:0)
[13:16:31.396] Timer tick, asking Buildbucket for the build status
[13:16:31.816] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:31.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:276:0) after 1m0s
[13:17:31.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:276:0)
[13:17:31.831] Timer tick, asking Buildbucket for the build status
[13:17:31.979] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:31.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:277:0) after 1m0s
[13:18:31.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:277:0)
[13:18:31.994] Timer tick, asking Buildbucket for the build status
[13:18:32.150] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:32.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:278:0) after 1m0s
[13:19:32.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:278:0)
[13:19:32.129] Timer tick, asking Buildbucket for the build status
[13:19:32.490] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:32.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:279:0) after 1m0s
[13:20:32.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:279:0)
[13:20:32.519] Timer tick, asking Buildbucket for the build status
[13:20:32.594] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:32.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:280:0) after 1m0s
[13:21:32.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:280:0)
[13:21:32.699] Timer tick, asking Buildbucket for the build status
[13:21:32.810] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:32.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:281:0) after 1m0s
[13:22:32.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:281:0)
[13:22:32.843] Timer tick, asking Buildbucket for the build status
[13:22:33.191] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:33.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:282:0) after 1m0s
[13:23:33.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:282:0)
[13:23:33.252] Timer tick, asking Buildbucket for the build status
[13:23:33.365] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:33.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:283:0) after 1m0s
[13:24:33.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:283:0)
[13:24:33.392] Timer tick, asking Buildbucket for the build status
[13:24:33.746] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:33.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:284:0) after 1m0s
[13:25:33.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:284:0)
[13:25:33.913] Timer tick, asking Buildbucket for the build status
[13:25:34.071] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:34.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:285:0) after 1m0s
[13:26:36.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:285:0)
[13:26:36.478] Timer tick, asking Buildbucket for the build status
[13:26:38.383] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:38.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:286:0) after 1m0s
[13:27:38.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:286:0)
[13:27:38.437] Timer tick, asking Buildbucket for the build status
[13:27:38.576] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:38.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:287:0) after 1m0s
[13:28:38.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:287:0)
[13:28:38.611] Timer tick, asking Buildbucket for the build status
[13:28:38.717] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:38.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:288:0) after 1m0s
[13:29:38.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:288:0)
[13:29:38.778] Timer tick, asking Buildbucket for the build status
[13:29:38.832] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:38.832] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:289:0) after 1m0s
[13:30:38.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:289:0)
[13:30:38.878] Timer tick, asking Buildbucket for the build status
[13:30:39.354] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:39.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:290:0) after 1m0s
[13:31:39.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:290:0)
[13:31:39.364] Timer tick, asking Buildbucket for the build status
[13:31:39.579] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:39.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:291:0) after 1m0s
[13:32:39.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:291:0)
[13:32:39.557] Timer tick, asking Buildbucket for the build status
[13:32:39.678] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:39.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:292:0) after 1m0s
[13:33:39.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:292:0)
[13:33:39.703] Timer tick, asking Buildbucket for the build status
[13:33:39.851] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:39.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:293:0) after 1m0s
[13:34:39.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:293:0)
[13:34:39.904] Timer tick, asking Buildbucket for the build status
[13:34:40.073] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:40.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:294:0) after 1m0s
[13:35:40.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:294:0)
[13:35:40.131] Timer tick, asking Buildbucket for the build status
[13:35:40.228] Build 8884868927430508944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:40.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050298989495479664:295:0) after 1m0s
[13:36:09.973] Received PubSub notification, asking Buildbucket for the build status
[13:36:10.048] Build 8884868927430508944: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:36:10.048] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1585143369089085",
"created_by": "project:infra",
"created_ts": "1585125721481387",
"id": "8884868927430508944",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4095.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ed29e958-7ec2-4d5d-88a8-683150e989d2\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4095.0\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4095.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ed29e958-7ec2-4d5d-88a8-683150e989d2\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-c4y1\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"83.0.4095.0\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-c4y1\"], \"image\": [\"chrome-xenial-20032200-f0f7a76907a\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4895-ce889b2\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585132392303648",
"status": "COMPLETED",
"status_changed_ts": "1585143369552591",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9050298989495479664",
"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/8884868927430508944/+/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:4b29aca61ac75810",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1585143369565749",
"url": "https://ci.chromium.org/b/8884868927430508944",
"utcnow_ts": "1585143370039496"
}
}
[13:36:10.048] Invocation finished in 4h54m9.920726487s with status SUCCEEDED