[19:40:56.425] New invocation is queued and will start shortly
[19:40:56.425] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[19:40:57.541] Starting the invocation (attempt 1)
[19:40:57.582] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:40:57.582] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:40:57.583] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9034403063581951632",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4240.42\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"315e3d7d-0cca-4af7-8877-239da8822bf5\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4240.42\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9034403063581951632",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[19:40:58.528] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1600285257766826",
"id": "8868973001511326336",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4240.42\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"315e3d7d-0cca-4af7-8877-239da8822bf5\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4240.42\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1600285258264693",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9034403063581951632",
"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/8868973001511326336/+/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": "1600285258265800",
"url": "https://ci.chromium.org/b/8868973001511326336",
"utcnow_ts": "1600285258507987"
}
}
[19:40:58.528] Task URL: https://ci.chromium.org/b/8868973001511326336
[19:40:58.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:2:0) after 1m0s
[19:41:33.981] Received PubSub notification, asking Buildbucket for the build status
[19:41:34.364] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:58.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:2:0)
[19:41:58.616] Timer tick, asking Buildbucket for the build status
[19:41:59.031] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:59.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:4:0) after 1m0s
[19:42:59.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:4:0)
[19:42:59.109] Timer tick, asking Buildbucket for the build status
[19:42:59.229] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:59.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:5:0) after 1m0s
[19:43:59.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:5:0)
[19:43:59.323] Timer tick, asking Buildbucket for the build status
[19:43:59.484] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:59.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:6:0) after 1m0s
[19:44:59.509] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:6:0)
[19:44:59.509] Timer tick, asking Buildbucket for the build status
[19:44:59.710] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:59.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:7:0) after 1m0s
[19:45:59.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:7:0)
[19:45:59.744] Timer tick, asking Buildbucket for the build status
[19:45:59.900] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:59.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:8:0) after 1m0s
[19:46:59.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:8:0)
[19:46:59.954] Timer tick, asking Buildbucket for the build status
[19:47:00.146] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:00.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:9:0) after 1m0s
[19:48:00.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:9:0)
[19:48:00.160] Timer tick, asking Buildbucket for the build status
[19:48:00.235] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:00.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:10:0) after 1m0s
[19:49:00.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:10:0)
[19:49:00.296] Timer tick, asking Buildbucket for the build status
[19:49:00.367] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:00.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:11:0) after 1m0s
[19:50:00.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:11:0)
[19:50:00.387] Timer tick, asking Buildbucket for the build status
[19:50:00.586] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:00.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:12:0) after 1m0s
[19:51:00.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:12:0)
[19:51:00.633] Timer tick, asking Buildbucket for the build status
[19:51:00.752] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:00.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:13:0) after 1m0s
[19:52:00.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:13:0)
[19:52:00.774] Timer tick, asking Buildbucket for the build status
[19:52:00.850] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:00.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:14:0) after 1m0s
[19:53:00.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:14:0)
[19:53:00.906] Timer tick, asking Buildbucket for the build status
[19:53:00.978] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:00.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:15:0) after 1m0s
[19:54:01.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:15:0)
[19:54:01.003] Timer tick, asking Buildbucket for the build status
[19:54:01.060] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:01.060] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:16:0) after 1m0s
[19:55:02.944] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:16:0)
[19:55:02.944] Timer tick, asking Buildbucket for the build status
[19:55:03.137] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:03.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:17:0) after 1m0s
[19:56:03.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:17:0)
[19:56:03.183] Timer tick, asking Buildbucket for the build status
[19:56:03.366] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:03.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:18:0) after 1m0s
[19:57:03.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:18:0)
[19:57:03.480] Timer tick, asking Buildbucket for the build status
[19:57:04.381] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:04.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:19:0) after 1m0s
[19:58:04.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:19:0)
[19:58:04.402] Timer tick, asking Buildbucket for the build status
[19:58:04.489] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:04.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:20:0) after 1m0s
[19:59:04.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:20:0)
[19:59:04.514] Timer tick, asking Buildbucket for the build status
[19:59:04.597] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:04.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:21:0) after 1m0s
[20:00:04.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:21:0)
[20:00:04.645] Timer tick, asking Buildbucket for the build status
[20:00:04.943] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:04.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:22:0) after 1m0s
[20:01:04.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:22:0)
[20:01:04.989] Timer tick, asking Buildbucket for the build status
[20:01:05.175] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:05.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:23:0) after 1m0s
[20:02:05.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:23:0)
[20:02:05.209] Timer tick, asking Buildbucket for the build status
[20:02:05.305] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:05.305] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:24:0) after 1m0s
[20:03:05.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:24:0)
[20:03:05.385] Timer tick, asking Buildbucket for the build status
[20:03:05.497] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:05.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:25:0) after 1m0s
[20:04:05.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:25:0)
[20:04:05.520] Timer tick, asking Buildbucket for the build status
[20:04:05.900] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:05.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:26:0) after 1m0s
[20:05:05.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:26:0)
[20:05:05.920] Timer tick, asking Buildbucket for the build status
[20:05:06.080] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:06.080] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:27:0) after 1m0s
[20:06:06.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:27:0)
[20:06:06.154] Timer tick, asking Buildbucket for the build status
[20:06:06.267] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:06.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:28:0) after 1m0s
[20:07:06.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:28:0)
[20:07:06.363] Timer tick, asking Buildbucket for the build status
[20:07:06.467] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:06.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:29:0) after 1m0s
[20:08:06.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:29:0)
[20:08:06.795] Timer tick, asking Buildbucket for the build status
[20:08:06.988] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:06.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:30:0) after 1m0s
[20:09:07.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:30:0)
[20:09:07.086] Timer tick, asking Buildbucket for the build status
[20:09:07.184] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:07.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:31:0) after 1m0s
[20:10:07.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:31:0)
[20:10:07.341] Timer tick, asking Buildbucket for the build status
[20:10:07.746] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:07.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:32:0) after 1m0s
[20:11:07.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:32:0)
[20:11:07.835] Timer tick, asking Buildbucket for the build status
[20:11:07.968] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:07.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:33:0) after 1m0s
[20:12:08.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:33:0)
[20:12:08.005] Timer tick, asking Buildbucket for the build status
[20:12:08.110] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:08.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:34:0) after 1m0s
[20:13:08.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:34:0)
[20:13:08.202] Timer tick, asking Buildbucket for the build status
[20:13:08.282] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:08.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:35:0) after 1m0s
[20:14:08.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:35:0)
[20:14:08.440] Timer tick, asking Buildbucket for the build status
[20:14:08.602] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:08.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:36:0) after 1m0s
[20:15:08.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:36:0)
[20:15:08.676] Timer tick, asking Buildbucket for the build status
[20:15:08.756] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:08.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:37:0) after 1m0s
[20:16:08.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:37:0)
[20:16:08.833] Timer tick, asking Buildbucket for the build status
[20:16:08.987] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:08.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:38:0) after 1m0s
[20:17:09.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:38:0)
[20:17:09.122] Timer tick, asking Buildbucket for the build status
[20:17:09.276] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:09.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:39:0) after 1m0s
[20:18:09.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:39:0)
[20:18:09.564] Timer tick, asking Buildbucket for the build status
[20:18:09.680] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:09.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:40:0) after 1m0s
[20:19:09.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:40:0)
[20:19:09.727] Timer tick, asking Buildbucket for the build status
[20:19:09.813] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:09.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:41:0) after 1m0s
[20:20:09.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:41:0)
[20:20:09.862] Timer tick, asking Buildbucket for the build status
[20:20:10.074] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:10.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:42:0) after 1m0s
[20:21:10.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:42:0)
[20:21:10.192] Timer tick, asking Buildbucket for the build status
[20:21:10.378] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:10.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:43:0) after 1m0s
[20:22:10.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:43:0)
[20:22:10.436] Timer tick, asking Buildbucket for the build status
[20:22:10.546] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:10.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:44:0) after 1m0s
[20:23:10.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:44:0)
[20:23:10.600] Timer tick, asking Buildbucket for the build status
[20:23:11.971] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:11.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:45:0) after 1m0s
[20:24:12.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:45:0)
[20:24:12.009] Timer tick, asking Buildbucket for the build status
[20:24:12.097] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:12.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:46:0) after 1m0s
[20:25:12.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:46:0)
[20:25:12.115] Timer tick, asking Buildbucket for the build status
[20:25:12.292] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:12.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:47:0) after 1m0s
[20:26:12.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:47:0)
[20:26:12.297] Timer tick, asking Buildbucket for the build status
[20:26:12.410] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:12.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:48:0) after 1m0s
[20:27:12.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:48:0)
[20:27:12.484] Timer tick, asking Buildbucket for the build status
[20:27:12.642] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:12.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:49:0) after 1m0s
[20:28:12.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:49:0)
[20:28:12.677] Timer tick, asking Buildbucket for the build status
[20:28:12.749] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:12.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:50:0) after 1m0s
[20:29:12.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:50:0)
[20:29:12.788] Timer tick, asking Buildbucket for the build status
[20:29:12.905] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:12.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:51:0) after 1m0s
[20:30:12.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:51:0)
[20:30:12.947] Timer tick, asking Buildbucket for the build status
[20:30:13.845] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:13.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:52:0) after 1m0s
[20:31:13.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:52:0)
[20:31:13.891] Timer tick, asking Buildbucket for the build status
[20:31:14.036] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:14.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:53:0) after 1m0s
[20:32:14.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:53:0)
[20:32:14.062] Timer tick, asking Buildbucket for the build status
[20:32:14.286] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:14.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:54:0) after 1m0s
[20:33:14.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:54:0)
[20:33:14.327] Timer tick, asking Buildbucket for the build status
[20:33:14.497] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:14.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:55:0) after 1m0s
[20:34:14.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:55:0)
[20:34:14.546] Timer tick, asking Buildbucket for the build status
[20:34:14.625] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:14.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:56:0) after 1m0s
[20:35:14.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:56:0)
[20:35:14.794] Timer tick, asking Buildbucket for the build status
[20:35:14.871] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:14.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:57:0) after 1m0s
[20:36:14.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:57:0)
[20:36:14.901] Timer tick, asking Buildbucket for the build status
[20:36:15.313] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:15.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:58:0) after 1m0s
[20:37:15.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:58:0)
[20:37:15.384] Timer tick, asking Buildbucket for the build status
[20:37:15.473] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:15.473] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:59:0) after 1m0s
[20:38:15.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:59:0)
[20:38:15.527] Timer tick, asking Buildbucket for the build status
[20:38:15.725] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:15.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:60:0) after 1m0s
[20:39:15.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:60:0)
[20:39:15.869] Timer tick, asking Buildbucket for the build status
[20:39:15.986] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:15.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:61:0) after 1m0s
[20:40:16.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:61:0)
[20:40:16.011] Timer tick, asking Buildbucket for the build status
[20:40:16.101] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:16.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:62:0) after 1m0s
[20:41:16.130] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:62:0)
[20:41:16.130] Timer tick, asking Buildbucket for the build status
[20:41:16.308] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:16.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:63:0) after 1m0s
[20:42:16.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:63:0)
[20:42:16.369] Timer tick, asking Buildbucket for the build status
[20:42:16.443] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:16.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:64:0) after 1m0s
[20:43:16.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:64:0)
[20:43:16.424] Timer tick, asking Buildbucket for the build status
[20:43:16.487] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:16.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:65:0) after 1m0s
[20:44:16.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:65:0)
[20:44:16.522] Timer tick, asking Buildbucket for the build status
[20:44:16.613] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:16.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:66:0) after 1m0s
[20:45:16.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:66:0)
[20:45:16.646] Timer tick, asking Buildbucket for the build status
[20:45:16.734] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:16.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:67:0) after 1m0s
[20:46:16.844] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:67:0)
[20:46:16.844] Timer tick, asking Buildbucket for the build status
[20:46:17.094] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:17.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:68:0) after 1m0s
[20:47:17.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:68:0)
[20:47:17.151] Timer tick, asking Buildbucket for the build status
[20:47:17.239] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:17.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:69:0) after 1m0s
[20:48:17.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:69:0)
[20:48:17.275] Timer tick, asking Buildbucket for the build status
[20:48:17.346] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:17.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:70:0) after 1m0s
[20:49:17.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:70:0)
[20:49:17.397] Timer tick, asking Buildbucket for the build status
[20:49:17.458] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:17.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:71:0) after 1m0s
[20:50:17.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:71:0)
[20:50:17.508] Timer tick, asking Buildbucket for the build status
[20:50:17.592] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:17.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:72:0) after 1m0s
[20:51:17.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:72:0)
[20:51:17.690] Timer tick, asking Buildbucket for the build status
[20:51:17.801] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:17.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:73:0) after 1m0s
[20:52:17.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:73:0)
[20:52:17.928] Timer tick, asking Buildbucket for the build status
[20:52:18.069] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:18.069] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:74:0) after 1m0s
[20:53:18.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:74:0)
[20:53:18.116] Timer tick, asking Buildbucket for the build status
[20:53:18.494] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:18.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:75:0) after 1m0s
[20:54:18.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:75:0)
[20:54:18.611] Timer tick, asking Buildbucket for the build status
[20:54:18.699] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:18.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:76:0) after 1m0s
[20:55:18.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:76:0)
[20:55:18.709] Timer tick, asking Buildbucket for the build status
[20:55:18.766] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:18.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:77:0) after 1m0s
[20:56:18.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:77:0)
[20:56:18.825] Timer tick, asking Buildbucket for the build status
[20:56:19.088] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:19.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:78:0) after 1m0s
[20:57:19.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:78:0)
[20:57:19.143] Timer tick, asking Buildbucket for the build status
[20:57:19.230] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:19.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:79:0) after 1m0s
[20:58:19.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:79:0)
[20:58:19.223] Timer tick, asking Buildbucket for the build status
[20:58:19.283] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:19.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:80:0) after 1m0s
[20:59:19.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:80:0)
[20:59:19.348] Timer tick, asking Buildbucket for the build status
[20:59:19.429] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:19.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:81:0) after 1m0s
[21:00:19.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:81:0)
[21:00:19.522] Timer tick, asking Buildbucket for the build status
[21:00:19.645] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:19.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:82:0) after 1m0s
[21:01:19.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:82:0)
[21:01:19.648] Timer tick, asking Buildbucket for the build status
[21:01:20.109] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:20.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:83:0) after 1m0s
[21:02:20.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:83:0)
[21:02:20.203] Timer tick, asking Buildbucket for the build status
[21:02:20.291] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:20.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:84:0) after 1m0s
[21:03:20.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:84:0)
[21:03:20.298] Timer tick, asking Buildbucket for the build status
[21:03:20.366] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:20.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:85:0) after 1m0s
[21:04:20.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:85:0)
[21:04:20.359] Timer tick, asking Buildbucket for the build status
[21:04:20.439] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:20.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:86:0) after 1m0s
[21:05:20.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:86:0)
[21:05:20.760] Timer tick, asking Buildbucket for the build status
[21:05:20.857] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:20.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:87:0) after 1m0s
[21:06:20.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:87:0)
[21:06:20.941] Timer tick, asking Buildbucket for the build status
[21:06:21.048] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:21.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:88:0) after 1m0s
[21:07:21.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:88:0)
[21:07:21.116] Timer tick, asking Buildbucket for the build status
[21:07:21.245] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:21.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:89:0) after 1m0s
[21:08:21.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:89:0)
[21:08:21.506] Timer tick, asking Buildbucket for the build status
[21:08:21.628] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:21.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:90:0) after 1m0s
[21:09:21.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:90:0)
[21:09:21.859] Timer tick, asking Buildbucket for the build status
[21:09:21.950] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:21.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:91:0) after 1m0s
[21:10:22.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:91:0)
[21:10:22.204] Timer tick, asking Buildbucket for the build status
[21:10:22.267] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:22.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:92:0) after 1m0s
[21:11:22.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:92:0)
[21:11:22.357] Timer tick, asking Buildbucket for the build status
[21:11:22.524] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:22.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:93:0) after 1m0s
[21:12:22.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:93:0)
[21:12:22.704] Timer tick, asking Buildbucket for the build status
[21:12:22.789] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:22.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:94:0) after 1m0s
[21:13:22.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:94:0)
[21:13:22.982] Timer tick, asking Buildbucket for the build status
[21:13:23.071] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:23.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:95:0) after 1m0s
[21:14:23.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:95:0)
[21:14:23.108] Timer tick, asking Buildbucket for the build status
[21:14:23.162] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:23.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:96:0) after 1m0s
[21:15:23.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:96:0)
[21:15:23.371] Timer tick, asking Buildbucket for the build status
[21:15:23.449] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:23.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:97:0) after 1m0s
[21:16:23.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:97:0)
[21:16:23.496] Timer tick, asking Buildbucket for the build status
[21:16:23.714] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:23.714] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:98:0) after 1m0s
[21:17:23.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:98:0)
[21:17:23.790] Timer tick, asking Buildbucket for the build status
[21:17:24.513] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:24.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:99:0) after 1m0s
[21:18:24.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:99:0)
[21:18:24.549] Timer tick, asking Buildbucket for the build status
[21:18:24.831] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:24.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:100:0) after 1m0s
[21:19:24.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:100:0)
[21:19:24.890] Timer tick, asking Buildbucket for the build status
[21:19:25.000] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:25.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:101:0) after 1m0s
[21:20:25.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:101:0)
[21:20:25.085] Timer tick, asking Buildbucket for the build status
[21:20:25.180] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:25.180] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:102:0) after 1m0s
[21:21:25.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:102:0)
[21:21:25.330] Timer tick, asking Buildbucket for the build status
[21:21:25.481] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:25.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:103:0) after 1m0s
[21:22:25.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:103:0)
[21:22:25.594] Timer tick, asking Buildbucket for the build status
[21:22:25.876] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:25.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:104:0) after 1m0s
[21:23:25.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:104:0)
[21:23:25.898] Timer tick, asking Buildbucket for the build status
[21:23:25.978] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:25.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:105:0) after 1m0s
[21:24:26.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:105:0)
[21:24:26.067] Timer tick, asking Buildbucket for the build status
[21:24:26.124] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:26.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:106:0) after 1m0s
[21:25:26.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:106:0)
[21:25:26.132] Timer tick, asking Buildbucket for the build status
[21:25:26.233] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:26.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:107:0) after 1m0s
[21:26:26.300] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:107:0)
[21:26:26.300] Timer tick, asking Buildbucket for the build status
[21:26:26.551] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:26.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:108:0) after 1m0s
[21:27:26.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:108:0)
[21:27:26.678] Timer tick, asking Buildbucket for the build status
[21:27:26.817] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:26.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:109:0) after 1m0s
[21:28:26.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:109:0)
[21:28:26.967] Timer tick, asking Buildbucket for the build status
[21:28:29.281] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:29.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:110:0) after 1m0s
[21:29:29.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:110:0)
[21:29:29.851] Timer tick, asking Buildbucket for the build status
[21:29:29.949] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:29.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:111:0) after 1m0s
[21:30:30.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:111:0)
[21:30:30.198] Timer tick, asking Buildbucket for the build status
[21:30:30.278] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:30.278] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:112:0) after 1m0s
[21:31:30.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:112:0)
[21:31:30.516] Timer tick, asking Buildbucket for the build status
[21:31:30.619] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:30.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:113:0) after 1m0s
[21:32:30.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:113:0)
[21:32:30.686] Timer tick, asking Buildbucket for the build status
[21:32:31.048] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:31.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:114:0) after 1m0s
[21:33:31.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:114:0)
[21:33:31.069] Timer tick, asking Buildbucket for the build status
[21:33:31.141] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:31.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:115:0) after 1m0s
[21:34:31.332] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:115:0)
[21:34:31.332] Timer tick, asking Buildbucket for the build status
[21:34:31.409] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:31.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:116:0) after 1m0s
[21:35:31.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:116:0)
[21:35:31.622] Timer tick, asking Buildbucket for the build status
[21:35:31.686] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:31.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:117:0) after 1m0s
[21:36:31.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:117:0)
[21:36:31.725] Timer tick, asking Buildbucket for the build status
[21:36:31.992] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:31.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:118:0) after 1m0s
[21:37:32.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:118:0)
[21:37:32.259] Timer tick, asking Buildbucket for the build status
[21:37:32.330] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:32.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:119:0) after 1m0s
[21:38:32.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:119:0)
[21:38:32.388] Timer tick, asking Buildbucket for the build status
[21:38:32.454] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:32.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:120:0) after 1m0s
[21:39:32.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:120:0)
[21:39:32.613] Timer tick, asking Buildbucket for the build status
[21:39:32.691] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:32.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:121:0) after 1m0s
[21:40:32.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:121:0)
[21:40:32.763] Timer tick, asking Buildbucket for the build status
[21:40:32.846] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:32.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:122:0) after 1m0s
[21:41:32.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:122:0)
[21:41:32.935] Timer tick, asking Buildbucket for the build status
[21:41:33.062] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:33.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:123:0) after 1m0s
[21:42:33.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:123:0)
[21:42:33.172] Timer tick, asking Buildbucket for the build status
[21:42:33.307] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:33.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:124:0) after 1m0s
[21:43:33.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:124:0)
[21:43:33.416] Timer tick, asking Buildbucket for the build status
[21:43:33.497] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:33.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:125:0) after 1m0s
[21:44:33.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:125:0)
[21:44:33.521] Timer tick, asking Buildbucket for the build status
[21:44:33.688] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:33.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:126:0) after 1m0s
[21:45:33.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:126:0)
[21:45:33.726] Timer tick, asking Buildbucket for the build status
[21:45:33.790] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:33.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:127:0) after 1m0s
[21:46:33.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:127:0)
[21:46:33.898] Timer tick, asking Buildbucket for the build status
[21:46:34.123] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:34.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:128:0) after 1m0s
[21:47:34.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:128:0)
[21:47:34.202] Timer tick, asking Buildbucket for the build status
[21:47:35.113] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:35.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:129:0) after 1m0s
[21:48:35.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:129:0)
[21:48:35.161] Timer tick, asking Buildbucket for the build status
[21:48:35.329] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:35.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:130:0) after 1m0s
[21:49:35.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:130:0)
[21:49:35.431] Timer tick, asking Buildbucket for the build status
[21:49:35.519] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:35.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:131:0) after 1m0s
[21:50:35.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:131:0)
[21:50:35.593] Timer tick, asking Buildbucket for the build status
[21:50:36.560] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:36.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:132:0) after 1m0s
[21:51:36.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:132:0)
[21:51:36.621] Timer tick, asking Buildbucket for the build status
[21:51:36.865] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:36.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:133:0) after 1m0s
[21:52:37.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:133:0)
[21:52:37.018] Timer tick, asking Buildbucket for the build status
[21:52:37.182] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:37.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:134:0) after 1m0s
[21:53:37.305] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:134:0)
[21:53:37.305] Timer tick, asking Buildbucket for the build status
[21:53:37.362] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:37.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:135:0) after 1m0s
[21:54:37.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:135:0)
[21:54:37.473] Timer tick, asking Buildbucket for the build status
[21:54:37.552] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:37.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:136:0) after 1m0s
[21:55:37.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:136:0)
[21:55:37.644] Timer tick, asking Buildbucket for the build status
[21:55:37.709] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:37.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:137:0) after 1m0s
[21:56:37.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:137:0)
[21:56:37.746] Timer tick, asking Buildbucket for the build status
[21:56:37.913] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:37.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:138:0) after 1m0s
[21:57:38.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:138:0)
[21:57:38.054] Timer tick, asking Buildbucket for the build status
[21:57:38.143] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:38.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:139:0) after 1m0s
[21:58:38.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:139:0)
[21:58:38.266] Timer tick, asking Buildbucket for the build status
[21:58:38.358] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:38.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:140:0) after 1m0s
[21:59:38.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:140:0)
[21:59:38.452] Timer tick, asking Buildbucket for the build status
[21:59:38.513] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:38.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:141:0) after 1m0s
[22:00:38.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:141:0)
[22:00:38.680] Timer tick, asking Buildbucket for the build status
[22:00:39.099] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:39.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:142:0) after 1m0s
[22:01:39.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:142:0)
[22:01:39.202] Timer tick, asking Buildbucket for the build status
[22:01:39.329] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:39.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:143:0) after 1m0s
[22:02:39.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:143:0)
[22:02:39.339] Timer tick, asking Buildbucket for the build status
[22:02:40.839] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:40.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:144:0) after 1m0s
[22:03:40.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:144:0)
[22:03:40.921] Timer tick, asking Buildbucket for the build status
[22:03:40.997] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:40.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:145:0) after 1m0s
[22:04:41.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:145:0)
[22:04:41.038] Timer tick, asking Buildbucket for the build status
[22:04:41.122] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:41.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:146:0) after 1m0s
[22:05:41.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:146:0)
[22:05:41.168] Timer tick, asking Buildbucket for the build status
[22:05:41.249] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:41.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:147:0) after 1m0s
[22:06:41.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:147:0)
[22:06:41.293] Timer tick, asking Buildbucket for the build status
[22:06:41.627] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:41.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:148:0) after 1m0s
[22:07:41.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:148:0)
[22:07:41.618] Timer tick, asking Buildbucket for the build status
[22:07:41.674] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:41.674] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:149:0) after 1m0s
[22:08:41.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:149:0)
[22:08:41.733] Timer tick, asking Buildbucket for the build status
[22:08:41.794] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:41.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:150:0) after 1m0s
[22:09:41.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:150:0)
[22:09:41.849] Timer tick, asking Buildbucket for the build status
[22:09:41.928] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:41.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:151:0) after 1m0s
[22:10:42.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:151:0)
[22:10:42.168] Timer tick, asking Buildbucket for the build status
[22:10:42.248] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:42.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:152:0) after 1m0s
[22:11:42.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:152:0)
[22:11:42.802] Timer tick, asking Buildbucket for the build status
[22:11:43.091] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:43.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:153:0) after 1m0s
[22:12:43.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:153:0)
[22:12:43.266] Timer tick, asking Buildbucket for the build status
[22:12:43.354] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:43.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:154:0) after 1m0s
[22:13:43.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:154:0)
[22:13:43.467] Timer tick, asking Buildbucket for the build status
[22:13:43.837] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:43.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:155:0) after 1m0s
[22:14:43.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:155:0)
[22:14:43.908] Timer tick, asking Buildbucket for the build status
[22:14:43.984] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:43.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:156:0) after 1m0s
[22:15:44.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:156:0)
[22:15:44.142] Timer tick, asking Buildbucket for the build status
[22:15:44.439] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:44.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:157:0) after 1m0s
[22:16:44.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:157:0)
[22:16:44.480] Timer tick, asking Buildbucket for the build status
[22:16:44.626] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:44.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:158:0) after 1m0s
[22:17:44.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:158:0)
[22:17:44.703] Timer tick, asking Buildbucket for the build status
[22:17:44.778] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:44.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:159:0) after 1m0s
[22:18:44.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:159:0)
[22:18:44.885] Timer tick, asking Buildbucket for the build status
[22:18:44.971] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:44.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:160:0) after 1m0s
[22:19:45.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:160:0)
[22:19:45.124] Timer tick, asking Buildbucket for the build status
[22:19:45.631] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:45.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:161:0) after 1m0s
[22:20:45.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:161:0)
[22:20:45.728] Timer tick, asking Buildbucket for the build status
[22:20:45.808] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:45.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:162:0) after 1m0s
[22:21:45.980] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:162:0)
[22:21:45.980] Timer tick, asking Buildbucket for the build status
[22:21:46.077] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:46.077] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:163:0) after 1m0s
[22:22:46.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:163:0)
[22:22:46.346] Timer tick, asking Buildbucket for the build status
[22:22:46.488] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:46.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:164:0) after 1m0s
[22:23:46.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:164:0)
[22:23:46.564] Timer tick, asking Buildbucket for the build status
[22:23:46.777] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:46.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:165:0) after 1m0s
[22:24:46.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:165:0)
[22:24:46.840] Timer tick, asking Buildbucket for the build status
[22:24:46.930] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:46.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:166:0) after 1m0s
[22:25:46.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:166:0)
[22:25:46.981] Timer tick, asking Buildbucket for the build status
[22:25:47.428] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:47.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:167:0) after 1m0s
[22:26:47.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:167:0)
[22:26:47.436] Timer tick, asking Buildbucket for the build status
[22:26:47.915] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:47.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:168:0) after 1m0s
[22:27:47.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:168:0)
[22:27:47.964] Timer tick, asking Buildbucket for the build status
[22:27:48.045] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:48.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:169:0) after 1m0s
[22:28:48.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:169:0)
[22:28:48.107] Timer tick, asking Buildbucket for the build status
[22:28:48.311] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:48.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:170:0) after 1m0s
[22:29:48.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:170:0)
[22:29:48.323] Timer tick, asking Buildbucket for the build status
[22:29:48.575] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:48.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:171:0) after 1m0s
[22:30:48.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:171:0)
[22:30:48.640] Timer tick, asking Buildbucket for the build status
[22:30:48.706] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:48.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:172:0) after 1m0s
[22:31:48.772] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:172:0)
[22:31:48.772] Timer tick, asking Buildbucket for the build status
[22:31:48.900] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:48.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:173:0) after 1m0s
[22:32:48.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:173:0)
[22:32:48.967] Timer tick, asking Buildbucket for the build status
[22:32:49.084] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:49.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:174:0) after 1m0s
[22:33:49.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:174:0)
[22:33:49.088] Timer tick, asking Buildbucket for the build status
[22:33:49.150] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:49.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:175:0) after 1m0s
[22:34:49.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:175:0)
[22:34:49.188] Timer tick, asking Buildbucket for the build status
[22:34:49.466] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:49.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:176:0) after 1m0s
[22:35:49.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:176:0)
[22:35:49.534] Timer tick, asking Buildbucket for the build status
[22:35:49.622] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:49.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:177:0) after 1m0s
[22:36:49.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:177:0)
[22:36:49.712] Timer tick, asking Buildbucket for the build status
[22:36:49.902] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:49.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:178:0) after 1m0s
[22:37:49.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:178:0)
[22:37:49.953] Timer tick, asking Buildbucket for the build status
[22:37:50.062] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:50.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:179:0) after 1m0s
[22:38:50.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:179:0)
[22:38:50.177] Timer tick, asking Buildbucket for the build status
[22:38:50.318] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:50.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:180:0) after 1m0s
[22:39:50.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:180:0)
[22:39:50.408] Timer tick, asking Buildbucket for the build status
[22:39:50.554] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:50.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:181:0) after 1m0s
[22:40:50.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:181:0)
[22:40:50.647] Timer tick, asking Buildbucket for the build status
[22:40:50.867] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:50.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:182:0) after 1m0s
[22:41:51.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:182:0)
[22:41:51.029] Timer tick, asking Buildbucket for the build status
[22:41:51.153] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:51.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:183:0) after 1m0s
[22:42:51.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:183:0)
[22:42:51.177] Timer tick, asking Buildbucket for the build status
[22:42:51.266] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:51.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:184:0) after 1m0s
[22:43:51.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:184:0)
[22:43:51.325] Timer tick, asking Buildbucket for the build status
[22:43:51.427] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:51.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:185:0) after 1m0s
[22:44:51.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:185:0)
[22:44:51.602] Timer tick, asking Buildbucket for the build status
[22:44:51.684] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:51.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:186:0) after 1m0s
[22:45:51.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:186:0)
[22:45:51.762] Timer tick, asking Buildbucket for the build status
[22:45:52.044] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:52.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:187:0) after 1m0s
[22:46:52.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:187:0)
[22:46:52.128] Timer tick, asking Buildbucket for the build status
[22:46:52.236] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:52.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:188:0) after 1m0s
[22:47:52.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:188:0)
[22:47:52.383] Timer tick, asking Buildbucket for the build status
[22:47:52.765] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:52.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:189:0) after 1m0s
[22:48:52.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:189:0)
[22:48:52.887] Timer tick, asking Buildbucket for the build status
[22:48:53.070] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:53.070] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:190:0) after 1m0s
[22:49:53.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:190:0)
[22:49:53.273] Timer tick, asking Buildbucket for the build status
[22:49:53.326] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:53.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:191:0) after 1m0s
[22:50:53.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:191:0)
[22:50:53.418] Timer tick, asking Buildbucket for the build status
[22:50:53.481] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:53.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:192:0) after 1m0s
[22:51:53.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:192:0)
[22:51:53.579] Timer tick, asking Buildbucket for the build status
[22:51:53.996] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:53.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:193:0) after 1m0s
[22:52:54.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:193:0)
[22:52:54.094] Timer tick, asking Buildbucket for the build status
[22:52:54.158] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:54.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:194:0) after 1m0s
[22:53:54.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:194:0)
[22:53:54.183] Timer tick, asking Buildbucket for the build status
[22:53:54.332] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:54.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:195:0) after 1m0s
[22:54:54.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:195:0)
[22:54:54.441] Timer tick, asking Buildbucket for the build status
[22:54:54.622] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:54.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:196:0) after 1m0s
[22:55:54.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:196:0)
[22:55:54.664] Timer tick, asking Buildbucket for the build status
[22:55:54.770] Build 8868973001511326336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:54.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034403063581951632:197:0) after 1m0s
[22:56:44.144] Received PubSub notification, asking Buildbucket for the build status
[22:56:44.228] Build 8868973001511326336: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:56:44.228] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1600297003471444",
"created_by": "project:infra",
"created_ts": "1600285257766826",
"id": "8868973001511326336",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4240.42\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"315e3d7d-0cca-4af7-8877-239da8822bf5\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4240.42\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-lldl\"], \"image\": [\"chrome-xenial-20091300-9b3346fad90\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5522-67570db\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1600285292403467",
"status": "COMPLETED",
"status_changed_ts": "1600297003906937",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9034403063581951632",
"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/8868973001511326336/+/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:4eb140bd49298810",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1600297003920176",
"url": "https://ci.chromium.org/b/8868973001511326336",
"utcnow_ts": "1600297004218430"
}
}
[22:56:44.228] Invocation finished in 3h15m47.821031347s with status SUCCEEDED