[08:19:58.768] New invocation is queued and will start shortly
[08:19:58.768] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:20:00.042] Starting the invocation (attempt 1)
[08:20:00.082] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:20:00.082] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:20:00.082] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9032271578746562208",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4288.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"aaa3f453-d4c1-429c-bd94-23c90e2b5b71\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4288.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:9032271578746562208",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[08:20:01.534] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1602318001115185",
"id": "8866841515620998336",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4288.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"aaa3f453-d4c1-429c-bd94-23c90e2b5b71\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4288.0\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602318001383138",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9032271578746562208",
"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/8866841515620998336/+/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": "1602318001383467",
"url": "https://ci.chromium.org/b/8866841515620998336",
"utcnow_ts": "1602318001525041"
}
}
[08:20:01.535] Task URL: https://ci.chromium.org/b/8866841515620998336
[08:20:01.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:2:0) after 1m0s
[08:20:28.499] Received PubSub notification, asking Buildbucket for the build status
[08:20:28.571] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:01.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:2:0)
[08:21:01.656] Timer tick, asking Buildbucket for the build status
[08:21:01.813] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:01.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:4:0) after 1m0s
[08:22:01.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:4:0)
[08:22:01.839] Timer tick, asking Buildbucket for the build status
[08:22:01.951] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:01.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:5:0) after 1m0s
[08:23:02.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:5:0)
[08:23:02.096] Timer tick, asking Buildbucket for the build status
[08:23:02.241] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:02.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:6:0) after 1m0s
[08:24:02.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:6:0)
[08:24:02.378] Timer tick, asking Buildbucket for the build status
[08:24:02.768] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:02.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:7:0) after 1m0s
[08:25:02.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:7:0)
[08:25:02.874] Timer tick, asking Buildbucket for the build status
[08:25:03.076] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:03.076] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:8:0) after 1m0s
[08:26:03.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:8:0)
[08:26:03.185] Timer tick, asking Buildbucket for the build status
[08:26:03.312] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:03.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:9:0) after 1m0s
[08:27:03.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:9:0)
[08:27:03.374] Timer tick, asking Buildbucket for the build status
[08:27:03.448] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:03.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:10:0) after 1m0s
[08:28:03.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:10:0)
[08:28:03.517] Timer tick, asking Buildbucket for the build status
[08:28:03.989] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:03.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:11:0) after 1m0s
[08:29:04.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:11:0)
[08:29:04.043] Timer tick, asking Buildbucket for the build status
[08:29:04.113] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:04.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:12:0) after 1m0s
[08:30:04.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:12:0)
[08:30:04.154] Timer tick, asking Buildbucket for the build status
[08:30:04.251] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:04.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:13:0) after 1m0s
[08:31:04.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:13:0)
[08:31:04.275] Timer tick, asking Buildbucket for the build status
[08:31:04.960] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:04.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:14:0) after 1m0s
[08:32:04.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:14:0)
[08:32:04.991] Timer tick, asking Buildbucket for the build status
[08:32:05.059] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:05.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:15:0) after 1m0s
[08:33:05.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:15:0)
[08:33:05.132] Timer tick, asking Buildbucket for the build status
[08:33:05.189] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:05.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:16:0) after 1m0s
[08:34:05.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:16:0)
[08:34:05.218] Timer tick, asking Buildbucket for the build status
[08:34:05.287] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:05.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:17:0) after 1m0s
[08:35:05.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:17:0)
[08:35:05.313] Timer tick, asking Buildbucket for the build status
[08:35:05.718] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:05.718] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:18:0) after 1m0s
[08:36:05.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:18:0)
[08:36:05.742] Timer tick, asking Buildbucket for the build status
[08:36:05.826] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:05.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:19:0) after 1m0s
[08:37:05.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:19:0)
[08:37:05.920] Timer tick, asking Buildbucket for the build status
[08:37:05.992] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:05.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:20:0) after 1m0s
[08:38:06.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:20:0)
[08:38:06.110] Timer tick, asking Buildbucket for the build status
[08:38:06.198] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:06.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:21:0) after 1m0s
[08:39:06.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:21:0)
[08:39:06.219] Timer tick, asking Buildbucket for the build status
[08:39:06.590] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:06.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:22:0) after 1m0s
[08:40:06.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:22:0)
[08:40:06.631] Timer tick, asking Buildbucket for the build status
[08:40:06.745] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:06.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:23:0) after 1m0s
[08:41:06.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:23:0)
[08:41:06.779] Timer tick, asking Buildbucket for the build status
[08:41:06.855] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:06.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:24:0) after 1m0s
[08:42:06.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:24:0)
[08:42:06.880] Timer tick, asking Buildbucket for the build status
[08:42:07.306] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:07.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:25:0) after 1m0s
[08:43:07.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:25:0)
[08:43:07.423] Timer tick, asking Buildbucket for the build status
[08:43:07.530] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:07.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:26:0) after 1m0s
[08:44:07.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:26:0)
[08:44:07.552] Timer tick, asking Buildbucket for the build status
[08:44:07.815] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:07.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:27:0) after 1m0s
[08:45:07.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:27:0)
[08:45:07.857] Timer tick, asking Buildbucket for the build status
[08:45:08.000] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:08.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:28:0) after 1m0s
[08:46:08.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:28:0)
[08:46:08.028] Timer tick, asking Buildbucket for the build status
[08:46:08.121] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:08.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:29:0) after 1m0s
[08:47:08.207] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:29:0)
[08:47:08.207] Timer tick, asking Buildbucket for the build status
[08:47:08.280] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:08.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:30:0) after 1m0s
[08:48:08.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:30:0)
[08:48:08.359] Timer tick, asking Buildbucket for the build status
[08:48:08.732] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:08.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:31:0) after 1m0s
[08:49:08.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:31:0)
[08:49:08.749] Timer tick, asking Buildbucket for the build status
[08:49:08.812] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:08.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:32:0) after 1m0s
[08:50:08.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:32:0)
[08:50:08.843] Timer tick, asking Buildbucket for the build status
[08:50:08.981] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:08.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:33:0) after 1m0s
[08:51:09.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:33:0)
[08:51:09.077] Timer tick, asking Buildbucket for the build status
[08:51:09.153] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:09.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:34:0) after 1m0s
[08:52:09.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:34:0)
[08:52:09.404] Timer tick, asking Buildbucket for the build status
[08:52:09.479] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:09.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:35:0) after 1m0s
[08:53:09.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:35:0)
[08:53:09.841] Timer tick, asking Buildbucket for the build status
[08:53:09.927] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:09.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:36:0) after 1m0s
[08:54:10.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:36:0)
[08:54:10.184] Timer tick, asking Buildbucket for the build status
[08:54:10.267] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:10.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:37:0) after 1m0s
[08:55:10.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:37:0)
[08:55:10.511] Timer tick, asking Buildbucket for the build status
[08:55:10.894] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:10.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:38:0) after 1m0s
[08:56:11.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:38:0)
[08:56:11.096] Timer tick, asking Buildbucket for the build status
[08:56:11.219] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:11.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:39:0) after 1m0s
[08:57:11.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:39:0)
[08:57:11.336] Timer tick, asking Buildbucket for the build status
[08:57:11.413] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:11.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:40:0) after 1m0s
[08:58:11.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:40:0)
[08:58:11.653] Timer tick, asking Buildbucket for the build status
[08:58:11.786] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:11.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:41:0) after 1m0s
[08:59:11.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:41:0)
[08:59:11.892] Timer tick, asking Buildbucket for the build status
[08:59:11.973] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:11.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:42:0) after 1m0s
[09:00:12.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:42:0)
[09:00:12.408] Timer tick, asking Buildbucket for the build status
[09:00:13.155] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:13.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:43:0) after 1m0s
[09:01:13.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:43:0)
[09:01:13.178] Timer tick, asking Buildbucket for the build status
[09:01:13.257] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:13.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:44:0) after 1m0s
[09:02:13.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:44:0)
[09:02:13.287] Timer tick, asking Buildbucket for the build status
[09:02:13.353] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:13.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:45:0) after 1m0s
[09:03:13.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:45:0)
[09:03:13.404] Timer tick, asking Buildbucket for the build status
[09:03:13.454] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:13.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:46:0) after 1m0s
[09:04:13.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:46:0)
[09:04:13.478] Timer tick, asking Buildbucket for the build status
[09:04:13.576] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:13.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:47:0) after 1m0s
[09:05:13.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:47:0)
[09:05:13.638] Timer tick, asking Buildbucket for the build status
[09:05:13.882] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:13.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:48:0) after 1m0s
[09:06:13.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:48:0)
[09:06:13.933] Timer tick, asking Buildbucket for the build status
[09:06:14.044] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:14.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:49:0) after 1m0s
[09:07:14.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:49:0)
[09:07:14.073] Timer tick, asking Buildbucket for the build status
[09:07:14.153] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:14.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:50:0) after 1m0s
[09:08:14.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:50:0)
[09:08:14.299] Timer tick, asking Buildbucket for the build status
[09:08:14.364] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:14.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:51:0) after 1m0s
[09:09:14.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:51:0)
[09:09:14.452] Timer tick, asking Buildbucket for the build status
[09:09:14.584] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:14.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:52:0) after 1m0s
[09:10:14.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:52:0)
[09:10:14.667] Timer tick, asking Buildbucket for the build status
[09:10:14.864] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:14.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:53:0) after 1m0s
[09:11:14.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:53:0)
[09:11:14.913] Timer tick, asking Buildbucket for the build status
[09:11:14.971] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:14.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:54:0) after 1m0s
[09:12:14.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:54:0)
[09:12:14.992] Timer tick, asking Buildbucket for the build status
[09:12:15.083] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:15.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:55:0) after 1m0s
[09:13:15.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:55:0)
[09:13:15.147] Timer tick, asking Buildbucket for the build status
[09:13:15.321] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:15.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:56:0) after 1m0s
[09:14:16.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:56:0)
[09:14:16.129] Timer tick, asking Buildbucket for the build status
[09:14:16.218] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:16.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:57:0) after 1m0s
[09:15:16.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:57:0)
[09:15:16.454] Timer tick, asking Buildbucket for the build status
[09:15:16.572] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:16.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:58:0) after 1m0s
[09:16:16.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:58:0)
[09:16:16.606] Timer tick, asking Buildbucket for the build status
[09:16:16.669] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:16.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:59:0) after 1m0s
[09:17:16.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:59:0)
[09:17:16.962] Timer tick, asking Buildbucket for the build status
[09:17:17.018] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:17.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:60:0) after 1m0s
[09:18:17.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:60:0)
[09:18:17.202] Timer tick, asking Buildbucket for the build status
[09:18:17.281] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:17.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:61:0) after 1m0s
[09:19:18.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:61:0)
[09:19:18.155] Timer tick, asking Buildbucket for the build status
[09:19:18.365] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:18.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:62:0) after 1m0s
[09:20:18.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:62:0)
[09:20:18.550] Timer tick, asking Buildbucket for the build status
[09:20:18.695] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:18.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:63:0) after 1m0s
[09:21:18.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:63:0)
[09:21:18.812] Timer tick, asking Buildbucket for the build status
[09:21:18.882] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:18.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:64:0) after 1m0s
[09:22:19.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:64:0)
[09:22:19.082] Timer tick, asking Buildbucket for the build status
[09:22:19.220] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:19.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:65:0) after 1m0s
[09:23:19.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:65:0)
[09:23:19.349] Timer tick, asking Buildbucket for the build status
[09:23:20.299] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:20.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:66:0) after 1m0s
[09:24:20.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:66:0)
[09:24:20.494] Timer tick, asking Buildbucket for the build status
[09:24:20.547] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:20.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:67:0) after 1m0s
[09:25:20.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:67:0)
[09:25:20.734] Timer tick, asking Buildbucket for the build status
[09:25:21.074] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:21.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:68:0) after 1m0s
[09:26:21.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:68:0)
[09:26:21.056] Timer tick, asking Buildbucket for the build status
[09:26:21.139] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:21.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:69:0) after 1m0s
[09:27:21.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:69:0)
[09:27:21.161] Timer tick, asking Buildbucket for the build status
[09:27:21.230] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:21.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:70:0) after 1m0s
[09:28:21.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:70:0)
[09:28:21.224] Timer tick, asking Buildbucket for the build status
[09:28:21.280] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:21.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:71:0) after 1m0s
[09:29:21.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:71:0)
[09:29:21.331] Timer tick, asking Buildbucket for the build status
[09:29:21.723] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:21.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:72:0) after 1m0s
[09:30:21.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:72:0)
[09:30:21.802] Timer tick, asking Buildbucket for the build status
[09:30:21.980] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:21.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:73:0) after 1m0s
[09:31:22.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:73:0)
[09:31:22.004] Timer tick, asking Buildbucket for the build status
[09:31:22.069] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:22.069] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:74:0) after 1m0s
[09:32:22.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:74:0)
[09:32:22.092] Timer tick, asking Buildbucket for the build status
[09:32:22.167] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:22.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:75:0) after 1m0s
[09:33:22.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:75:0)
[09:33:22.197] Timer tick, asking Buildbucket for the build status
[09:33:22.366] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:22.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:76:0) after 1m0s
[09:34:22.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:76:0)
[09:34:22.423] Timer tick, asking Buildbucket for the build status
[09:34:22.484] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:22.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:77:0) after 1m0s
[09:35:22.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:77:0)
[09:35:22.512] Timer tick, asking Buildbucket for the build status
[09:35:22.899] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:22.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:78:0) after 1m0s
[09:36:22.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:78:0)
[09:36:22.986] Timer tick, asking Buildbucket for the build status
[09:36:23.184] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:23.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:79:0) after 1m0s
[09:37:23.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:79:0)
[09:37:23.166] Timer tick, asking Buildbucket for the build status
[09:37:23.232] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:23.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:80:0) after 1m0s
[09:38:23.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:80:0)
[09:38:23.320] Timer tick, asking Buildbucket for the build status
[09:38:23.401] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:23.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:81:0) after 1m0s
[09:39:23.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:81:0)
[09:39:23.424] Timer tick, asking Buildbucket for the build status
[09:39:23.479] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:23.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:82:0) after 1m0s
[09:40:23.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:82:0)
[09:40:23.544] Timer tick, asking Buildbucket for the build status
[09:40:24.083] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:24.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:83:0) after 1m0s
[09:41:24.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:83:0)
[09:41:24.101] Timer tick, asking Buildbucket for the build status
[09:41:24.200] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:24.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:84:0) after 1m0s
[09:42:24.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:84:0)
[09:42:24.250] Timer tick, asking Buildbucket for the build status
[09:42:24.313] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:24.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:85:0) after 1m0s
[09:43:24.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:85:0)
[09:43:24.338] Timer tick, asking Buildbucket for the build status
[09:43:24.418] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:24.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:86:0) after 1m0s
[09:44:24.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:86:0)
[09:44:24.461] Timer tick, asking Buildbucket for the build status
[09:44:24.547] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:24.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:87:0) after 1m0s
[09:45:24.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:87:0)
[09:45:24.601] Timer tick, asking Buildbucket for the build status
[09:45:24.896] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:24.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:88:0) after 1m0s
[09:46:24.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:88:0)
[09:46:24.893] Timer tick, asking Buildbucket for the build status
[09:46:25.122] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:25.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:89:0) after 1m0s
[09:47:25.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:89:0)
[09:47:25.183] Timer tick, asking Buildbucket for the build status
[09:47:25.254] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:25.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:90:0) after 1m0s
[09:48:25.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:90:0)
[09:48:25.272] Timer tick, asking Buildbucket for the build status
[09:48:25.365] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:25.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:91:0) after 1m0s
[09:49:25.456] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:91:0)
[09:49:25.456] Timer tick, asking Buildbucket for the build status
[09:49:25.529] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:25.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:92:0) after 1m0s
[09:50:25.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:92:0)
[09:50:25.572] Timer tick, asking Buildbucket for the build status
[09:50:25.697] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:25.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:93:0) after 1m0s
[09:51:25.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:93:0)
[09:51:25.773] Timer tick, asking Buildbucket for the build status
[09:51:25.880] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:25.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:94:0) after 1m0s
[09:52:25.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:94:0)
[09:52:25.963] Timer tick, asking Buildbucket for the build status
[09:52:26.032] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:26.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:95:0) after 1m0s
[09:53:26.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:95:0)
[09:53:26.122] Timer tick, asking Buildbucket for the build status
[09:53:26.207] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:26.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:96:0) after 1m0s
[09:54:26.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:96:0)
[09:54:26.250] Timer tick, asking Buildbucket for the build status
[09:54:26.577] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:26.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:97:0) after 1m0s
[09:55:27.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:97:0)
[09:55:27.324] Timer tick, asking Buildbucket for the build status
[09:55:27.440] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:27.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:98:0) after 1m0s
[09:56:27.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:98:0)
[09:56:27.611] Timer tick, asking Buildbucket for the build status
[09:56:27.668] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:27.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:99:0) after 1m0s
[09:57:27.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:99:0)
[09:57:27.731] Timer tick, asking Buildbucket for the build status
[09:57:28.063] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:28.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:100:0) after 1m0s
[09:58:28.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:100:0)
[09:58:28.165] Timer tick, asking Buildbucket for the build status
[09:58:28.300] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:28.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:101:0) after 1m0s
[09:59:28.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:101:0)
[09:59:28.342] Timer tick, asking Buildbucket for the build status
[09:59:28.417] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:28.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:102:0) after 1m0s
[10:00:28.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:102:0)
[10:00:28.569] Timer tick, asking Buildbucket for the build status
[10:00:28.689] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:28.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:103:0) after 1m0s
[10:01:28.781] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:103:0)
[10:01:28.781] Timer tick, asking Buildbucket for the build status
[10:01:28.857] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:28.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:104:0) after 1m0s
[10:02:28.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:104:0)
[10:02:28.904] Timer tick, asking Buildbucket for the build status
[10:02:28.966] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:28.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:105:0) after 1m0s
[10:03:29.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:105:0)
[10:03:29.008] Timer tick, asking Buildbucket for the build status
[10:03:29.377] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:29.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:106:0) after 1m0s
[10:04:29.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:106:0)
[10:04:29.517] Timer tick, asking Buildbucket for the build status
[10:04:29.575] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:29.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:107:0) after 1m0s
[10:05:29.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:107:0)
[10:05:29.605] Timer tick, asking Buildbucket for the build status
[10:05:29.716] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:29.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:108:0) after 1m0s
[10:06:29.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:108:0)
[10:06:29.713] Timer tick, asking Buildbucket for the build status
[10:06:29.900] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:29.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:109:0) after 1m0s
[10:07:29.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:109:0)
[10:07:29.984] Timer tick, asking Buildbucket for the build status
[10:07:30.210] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:30.210] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:110:0) after 1m0s
[10:08:30.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:110:0)
[10:08:30.250] Timer tick, asking Buildbucket for the build status
[10:08:30.324] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:30.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:111:0) after 1m0s
[10:09:30.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:111:0)
[10:09:30.387] Timer tick, asking Buildbucket for the build status
[10:09:30.457] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:30.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:112:0) after 1m0s
[10:10:30.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:112:0)
[10:10:30.559] Timer tick, asking Buildbucket for the build status
[10:10:30.671] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:30.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:113:0) after 1m0s
[10:11:30.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:113:0)
[10:11:30.777] Timer tick, asking Buildbucket for the build status
[10:11:30.970] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:30.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:114:0) after 1m0s
[10:12:31.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:114:0)
[10:12:31.043] Timer tick, asking Buildbucket for the build status
[10:12:31.283] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:31.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:115:0) after 1m0s
[10:13:31.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:115:0)
[10:13:31.447] Timer tick, asking Buildbucket for the build status
[10:13:31.504] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:31.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:116:0) after 1m0s
[10:14:31.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:116:0)
[10:14:31.517] Timer tick, asking Buildbucket for the build status
[10:14:31.595] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:31.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:117:0) after 1m0s
[10:15:31.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:117:0)
[10:15:31.621] Timer tick, asking Buildbucket for the build status
[10:15:31.743] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:31.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:118:0) after 1m0s
[10:16:31.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:118:0)
[10:16:31.871] Timer tick, asking Buildbucket for the build status
[10:16:31.958] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:31.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:119:0) after 1m0s
[10:17:31.952] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:119:0)
[10:17:31.952] Timer tick, asking Buildbucket for the build status
[10:17:32.022] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:32.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:120:0) after 1m0s
[10:18:32.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:120:0)
[10:18:32.086] Timer tick, asking Buildbucket for the build status
[10:18:32.154] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:32.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:121:0) after 1m0s
[10:19:32.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:121:0)
[10:19:32.284] Timer tick, asking Buildbucket for the build status
[10:19:32.373] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:32.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:122:0) after 1m0s
[10:20:32.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:122:0)
[10:20:32.512] Timer tick, asking Buildbucket for the build status
[10:20:32.712] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:32.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:123:0) after 1m0s
[10:21:32.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:123:0)
[10:21:32.717] Timer tick, asking Buildbucket for the build status
[10:21:32.773] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:32.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:124:0) after 1m0s
[10:22:32.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:124:0)
[10:22:32.833] Timer tick, asking Buildbucket for the build status
[10:22:33.092] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:33.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:125:0) after 1m0s
[10:23:33.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:125:0)
[10:23:33.122] Timer tick, asking Buildbucket for the build status
[10:23:33.182] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:33.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:126:0) after 1m0s
[10:24:33.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:126:0)
[10:24:33.369] Timer tick, asking Buildbucket for the build status
[10:24:33.427] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:33.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:127:0) after 1m0s
[10:25:33.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:127:0)
[10:25:33.547] Timer tick, asking Buildbucket for the build status
[10:25:33.786] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:33.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:128:0) after 1m0s
[10:26:33.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:128:0)
[10:26:33.917] Timer tick, asking Buildbucket for the build status
[10:26:34.010] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:34.010] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:129:0) after 1m0s
[10:27:34.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:129:0)
[10:27:34.154] Timer tick, asking Buildbucket for the build status
[10:27:34.322] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:34.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:130:0) after 1m0s
[10:28:34.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:130:0)
[10:28:34.438] Timer tick, asking Buildbucket for the build status
[10:28:34.514] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:34.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:131:0) after 1m0s
[10:29:34.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:131:0)
[10:29:34.712] Timer tick, asking Buildbucket for the build status
[10:29:34.822] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:34.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:132:0) after 1m0s
[10:30:34.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:132:0)
[10:30:34.925] Timer tick, asking Buildbucket for the build status
[10:30:35.035] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:35.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:133:0) after 1m0s
[10:31:35.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:133:0)
[10:31:35.064] Timer tick, asking Buildbucket for the build status
[10:31:35.222] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:35.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:134:0) after 1m0s
[10:32:35.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:134:0)
[10:32:35.288] Timer tick, asking Buildbucket for the build status
[10:32:35.552] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:35.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:135:0) after 1m0s
[10:33:35.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:135:0)
[10:33:35.581] Timer tick, asking Buildbucket for the build status
[10:33:35.640] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:35.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:136:0) after 1m0s
[10:34:35.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:136:0)
[10:34:35.689] Timer tick, asking Buildbucket for the build status
[10:34:35.897] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:35.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:137:0) after 1m0s
[10:35:35.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:137:0)
[10:35:35.963] Timer tick, asking Buildbucket for the build status
[10:35:36.093] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:36.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:138:0) after 1m0s
[10:36:36.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:138:0)
[10:36:36.091] Timer tick, asking Buildbucket for the build status
[10:36:36.208] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:36.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:139:0) after 1m0s
[10:37:36.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:139:0)
[10:37:36.245] Timer tick, asking Buildbucket for the build status
[10:37:36.316] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:36.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:140:0) after 1m0s
[10:38:36.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:140:0)
[10:38:36.373] Timer tick, asking Buildbucket for the build status
[10:38:36.564] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:36.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:141:0) after 1m0s
[10:39:36.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:141:0)
[10:39:36.572] Timer tick, asking Buildbucket for the build status
[10:39:36.648] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:36.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:142:0) after 1m0s
[10:40:36.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:142:0)
[10:40:36.698] Timer tick, asking Buildbucket for the build status
[10:40:36.822] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:36.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:143:0) after 1m0s
[10:41:36.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:143:0)
[10:41:36.899] Timer tick, asking Buildbucket for the build status
[10:41:36.972] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:36.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:144:0) after 1m0s
[10:42:36.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:144:0)
[10:42:36.998] Timer tick, asking Buildbucket for the build status
[10:42:37.068] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:37.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:145:0) after 1m0s
[10:43:37.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:145:0)
[10:43:37.086] Timer tick, asking Buildbucket for the build status
[10:43:56.500] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:56.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:146:0) after 1m0s
[10:44:56.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:146:0)
[10:44:56.581] Timer tick, asking Buildbucket for the build status
[10:44:56.650] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:56.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:147:0) after 1m0s
[10:45:56.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:147:0)
[10:45:56.710] Timer tick, asking Buildbucket for the build status
[10:45:56.843] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:56.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:148:0) after 1m0s
[10:46:56.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:148:0)
[10:46:56.882] Timer tick, asking Buildbucket for the build status
[10:46:56.968] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:56.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:149:0) after 1m0s
[10:47:56.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:149:0)
[10:47:56.985] Timer tick, asking Buildbucket for the build status
[10:47:57.073] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:57.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:150:0) after 1m0s
[10:48:57.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:150:0)
[10:48:57.099] Timer tick, asking Buildbucket for the build status
[10:48:57.339] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:57.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:151:0) after 1m0s
[10:49:57.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:151:0)
[10:49:57.411] Timer tick, asking Buildbucket for the build status
[10:49:57.469] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:57.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:152:0) after 1m0s
[10:50:57.504] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:152:0)
[10:50:57.505] Timer tick, asking Buildbucket for the build status
[10:50:57.629] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:57.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:153:0) after 1m0s
[10:51:57.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:153:0)
[10:51:57.674] Timer tick, asking Buildbucket for the build status
[10:51:58.114] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:58.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:154:0) after 1m0s
[10:52:58.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:154:0)
[10:52:58.203] Timer tick, asking Buildbucket for the build status
[10:52:58.261] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:58.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:155:0) after 1m0s
[10:53:58.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:155:0)
[10:53:58.287] Timer tick, asking Buildbucket for the build status
[10:53:58.348] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:58.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:156:0) after 1m0s
[10:54:58.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:156:0)
[10:54:58.373] Timer tick, asking Buildbucket for the build status
[10:54:58.446] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:58.446] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:157:0) after 1m0s
[10:55:58.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:157:0)
[10:55:58.473] Timer tick, asking Buildbucket for the build status
[10:55:58.885] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:58.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:158:0) after 1m0s
[10:56:58.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:158:0)
[10:56:58.914] Timer tick, asking Buildbucket for the build status
[10:56:59.003] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:59.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:159:0) after 1m0s
[10:57:59.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:159:0)
[10:57:59.062] Timer tick, asking Buildbucket for the build status
[10:57:59.118] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:59.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:160:0) after 1m0s
[10:58:59.180] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:160:0)
[10:58:59.180] Timer tick, asking Buildbucket for the build status
[10:58:59.299] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:59.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:161:0) after 1m0s
[10:59:59.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:161:0)
[10:59:59.374] Timer tick, asking Buildbucket for the build status
[10:59:59.428] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:59.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:162:0) after 1m0s
[11:00:59.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:162:0)
[11:00:59.469] Timer tick, asking Buildbucket for the build status
[11:00:59.587] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:59.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:163:0) after 1m0s
[11:01:59.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:163:0)
[11:01:59.691] Timer tick, asking Buildbucket for the build status
[11:01:59.819] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:59.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:164:0) after 1m0s
[11:02:59.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:164:0)
[11:02:59.857] Timer tick, asking Buildbucket for the build status
[11:02:59.928] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:59.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:165:0) after 1m0s
[11:04:00.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:165:0)
[11:04:00.063] Timer tick, asking Buildbucket for the build status
[11:04:00.191] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:00.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:166:0) after 1m0s
[11:05:00.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:166:0)
[11:05:00.191] Timer tick, asking Buildbucket for the build status
[11:05:00.753] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:00.753] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:167:0) after 1m0s
[11:06:01.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:167:0)
[11:06:01.408] Timer tick, asking Buildbucket for the build status
[11:06:03.308] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:03.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:168:0) after 1m0s
[11:07:03.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:168:0)
[11:07:03.336] Timer tick, asking Buildbucket for the build status
[11:07:03.487] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:03.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:169:0) after 1m0s
[11:08:03.630] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:169:0)
[11:08:03.630] Timer tick, asking Buildbucket for the build status
[11:08:03.699] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:03.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:170:0) after 1m0s
[11:09:03.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:170:0)
[11:09:03.776] Timer tick, asking Buildbucket for the build status
[11:09:03.846] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:03.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:171:0) after 1m0s
[11:10:03.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:171:0)
[11:10:03.867] Timer tick, asking Buildbucket for the build status
[11:10:03.932] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:03.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:172:0) after 1m0s
[11:11:04.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:172:0)
[11:11:04.062] Timer tick, asking Buildbucket for the build status
[11:11:04.181] Build 8866841515620998336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:04.181] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032271578746562208:173:0) after 1m0s
[11:11:22.389] Received PubSub notification, asking Buildbucket for the build status
[11:11:22.460] Build 8866841515620998336: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:11:22.460] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1602328281743401",
"created_by": "project:infra",
"created_ts": "1602318001115185",
"id": "8866841515620998336",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4288.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"aaa3f453-d4c1-429c-bd94-23c90e2b5b71\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4288.0\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-ooyh\"], \"image\": [\"chrome-xenial-20100800-ee496b8e3cf\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602318027307470",
"status": "COMPLETED",
"status_changed_ts": "1602328282122836",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9032271578746562208",
"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/8866841515620998336/+/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:4f2a69ede80aa610",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1602328282136184",
"url": "https://ci.chromium.org/b/8866841515620998336",
"utcnow_ts": "1602328282450889"
}
}
[11:11:22.460] Invocation finished in 2h51m23.709597536s with status SUCCEEDED