[00:37:02.466] New invocation is queued and will start shortly
[00:37:04.515] Starting the invocation (attempt 1)
[00:37:04.567] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:37:04.567] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:37:04.567] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9042175773652837584",
"parameters_json": "{\"builder_name\":\"publish_tarball_dispatcher\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"cron\":{\"generation\":\"11046\"},\"id\":\"cron:v1:11046\"}]}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:publish_tarball_dispatcher",
"scheduler_invocation_id:9042175773652837584",
"scheduler_job_id:infra/publish_tarball_dispatcher",
"user_agent:luci-scheduler"
]
}
[00:37:05.367] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1592872624706199",
"id": "8876745710634819216",
"parameters_json": "{\"builder_name\": \"publish_tarball_dispatcher\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"11046\"}, \"id\": \"cron:v1:11046\"}]}}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1592872624983323",
"tags": [
"builder:publish_tarball_dispatcher",
"scheduler_invocation_id:9042175773652837584",
"scheduler_job_id:infra/publish_tarball_dispatcher",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8876745710634819216/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:recipe_name:publish_tarball",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1592872624983495",
"url": "https://ci.chromium.org/b/8876745710634819216",
"utcnow_ts": "1592872625342262"
}
}
[00:37:05.367] Task URL: https://ci.chromium.org/b/8876745710634819216
[00:37:05.367] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:2:0) after 1m0s
[00:38:05.469] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:2:0)
[00:38:05.469] Timer tick, asking Buildbucket for the build status
[00:38:05.768] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:05.768] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:3:0) after 1m0s
[00:39:05.799] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:3:0)
[00:39:05.799] Timer tick, asking Buildbucket for the build status
[00:39:06.119] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:06.119] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:4:0) after 1m0s
[00:40:06.200] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:4:0)
[00:40:06.200] Timer tick, asking Buildbucket for the build status
[00:40:06.538] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:06.538] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:5:0) after 1m0s
[00:41:06.569] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:5:0)
[00:41:06.569] Timer tick, asking Buildbucket for the build status
[00:41:06.856] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:06.856] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:6:0) after 1m0s
[00:42:06.914] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:6:0)
[00:42:06.914] Timer tick, asking Buildbucket for the build status
[00:42:07.132] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:07.132] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:7:0) after 1m0s
[00:43:07.205] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:7:0)
[00:43:07.205] Timer tick, asking Buildbucket for the build status
[00:43:07.365] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:07.365] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:8:0) after 1m0s
[00:44:07.423] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:8:0)
[00:44:07.423] Timer tick, asking Buildbucket for the build status
[00:44:07.855] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:07.855] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:9:0) after 1m0s
[00:45:07.978] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:9:0)
[00:45:07.978] Timer tick, asking Buildbucket for the build status
[00:45:08.100] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:08.100] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:10:0) after 1m0s
[00:46:08.306] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:10:0)
[00:46:08.306] Timer tick, asking Buildbucket for the build status
[00:46:08.482] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:08.482] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:11:0) after 1m0s
[00:47:08.656] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:11:0)
[00:47:08.656] Timer tick, asking Buildbucket for the build status
[00:47:08.810] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:08.810] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:12:0) after 1m0s
[00:48:09.226] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:12:0)
[00:48:09.226] Timer tick, asking Buildbucket for the build status
[00:48:09.427] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:09.427] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:13:0) after 1m0s
[00:49:09.677] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:13:0)
[00:49:09.677] Timer tick, asking Buildbucket for the build status
[00:49:10.669] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:10.669] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:14:0) after 1m0s
[00:50:10.768] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:14:0)
[00:50:10.768] Timer tick, asking Buildbucket for the build status
[00:50:10.886] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:10.886] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:15:0) after 1m0s
[00:51:11.046] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:15:0)
[00:51:11.046] Timer tick, asking Buildbucket for the build status
[00:51:11.339] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:11.339] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:16:0) after 1m0s
[00:52:11.335] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:16:0)
[00:52:11.335] Timer tick, asking Buildbucket for the build status
[00:52:11.460] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:11.460] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:17:0) after 1m0s
[00:53:11.512] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:17:0)
[00:53:11.512] Timer tick, asking Buildbucket for the build status
[00:53:11.650] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:11.650] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:18:0) after 1m0s
[00:54:11.760] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:18:0)
[00:54:11.760] Timer tick, asking Buildbucket for the build status
[00:54:11.903] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:11.903] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:19:0) after 1m0s
[00:55:11.927] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:19:0)
[00:55:11.927] Timer tick, asking Buildbucket for the build status
[00:55:12.143] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:12.143] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:20:0) after 1m0s
[00:56:12.164] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:20:0)
[00:56:12.165] Timer tick, asking Buildbucket for the build status
[00:56:12.294] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:12.294] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:21:0) after 1m0s
[00:57:12.324] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:21:0)
[00:57:12.324] Timer tick, asking Buildbucket for the build status
[00:57:12.580] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:12.580] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:22:0) after 1m0s
[00:58:12.624] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:22:0)
[00:58:12.624] Timer tick, asking Buildbucket for the build status
[00:58:12.780] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:12.780] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:23:0) after 1m0s
[00:59:12.960] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:23:0)
[00:59:12.960] Timer tick, asking Buildbucket for the build status
[00:59:13.240] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:13.240] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:24:0) after 1m0s
[01:00:13.276] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:24:0)
[01:00:13.276] Timer tick, asking Buildbucket for the build status
[01:00:13.538] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:13.538] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:25:0) after 1m0s
[01:01:14.342] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:25:0)
[01:01:14.342] Timer tick, asking Buildbucket for the build status
[01:01:14.493] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:14.493] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:26:0) after 1m0s
[01:02:14.754] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:26:0)
[01:02:14.754] Timer tick, asking Buildbucket for the build status
[01:02:14.860] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:14.860] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:27:0) after 1m0s
[01:03:15.006] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:27:0)
[01:03:15.006] Timer tick, asking Buildbucket for the build status
[01:03:15.194] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:15.194] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:28:0) after 1m0s
[01:04:15.608] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:28:0)
[01:04:15.608] Timer tick, asking Buildbucket for the build status
[01:04:15.721] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:15.721] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:29:0) after 1m0s
[01:05:15.876] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:29:0)
[01:05:15.876] Timer tick, asking Buildbucket for the build status
[01:05:18.539] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:18.539] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:30:0) after 1m0s
[01:06:18.875] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:30:0)
[01:06:18.875] Timer tick, asking Buildbucket for the build status
[01:06:19.022] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:19.022] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:31:0) after 1m0s
[01:07:19.252] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:31:0)
[01:07:19.252] Timer tick, asking Buildbucket for the build status
[01:07:19.349] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:19.349] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:32:0) after 1m0s
[01:08:19.509] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:32:0)
[01:08:19.509] Timer tick, asking Buildbucket for the build status
[01:08:19.649] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:19.649] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:33:0) after 1m0s
[01:09:19.738] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:33:0)
[01:09:19.738] Timer tick, asking Buildbucket for the build status
[01:09:19.948] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:19.948] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:34:0) after 1m0s
[01:10:20.459] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:34:0)
[01:10:20.459] Timer tick, asking Buildbucket for the build status
[01:10:20.679] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:20.679] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:35:0) after 1m0s
[01:11:20.743] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:35:0)
[01:11:20.743] Timer tick, asking Buildbucket for the build status
[01:11:20.946] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:20.946] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:36:0) after 1m0s
[01:12:21.146] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:36:0)
[01:12:21.146] Timer tick, asking Buildbucket for the build status
[01:12:21.320] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:21.320] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:37:0) after 1m0s
[01:13:21.552] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:37:0)
[01:13:21.552] Timer tick, asking Buildbucket for the build status
[01:13:21.744] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:21.744] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:38:0) after 1m0s
[01:14:22.007] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:38:0)
[01:14:22.007] Timer tick, asking Buildbucket for the build status
[01:14:22.234] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:22.234] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:39:0) after 1m0s
[01:15:22.278] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:39:0)
[01:15:22.278] Timer tick, asking Buildbucket for the build status
[01:15:22.503] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:22.503] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:40:0) after 1m0s
[01:16:22.617] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:40:0)
[01:16:22.617] Timer tick, asking Buildbucket for the build status
[01:16:23.283] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:23.283] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:41:0) after 1m0s
[01:17:23.338] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:41:0)
[01:17:23.338] Timer tick, asking Buildbucket for the build status
[01:17:23.537] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:23.537] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:42:0) after 1m0s
[01:18:23.546] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:42:0)
[01:18:23.546] Timer tick, asking Buildbucket for the build status
[01:18:25.994] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:25.994] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:43:0) after 1m0s
[01:19:26.086] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:43:0)
[01:19:26.086] Timer tick, asking Buildbucket for the build status
[01:19:26.251] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:26.251] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:44:0) after 1m0s
[01:20:26.277] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:44:0)
[01:20:26.277] Timer tick, asking Buildbucket for the build status
[01:20:26.389] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:26.389] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:45:0) after 1m0s
[01:21:26.471] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:45:0)
[01:21:26.471] Timer tick, asking Buildbucket for the build status
[01:21:26.569] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:26.569] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:46:0) after 1m0s
[01:22:26.596] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:46:0)
[01:22:26.596] Timer tick, asking Buildbucket for the build status
[01:22:26.809] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:26.809] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:47:0) after 1m0s
[01:23:26.932] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:47:0)
[01:23:26.932] Timer tick, asking Buildbucket for the build status
[01:23:27.132] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:27.132] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:48:0) after 1m0s
[01:24:27.154] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:48:0)
[01:24:27.154] Timer tick, asking Buildbucket for the build status
[01:24:27.286] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:27.286] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:49:0) after 1m0s
[01:25:27.306] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:49:0)
[01:25:27.306] Timer tick, asking Buildbucket for the build status
[01:25:27.547] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:27.547] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:50:0) after 1m0s
[01:26:27.635] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:50:0)
[01:26:27.635] Timer tick, asking Buildbucket for the build status
[01:26:27.782] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:27.782] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:51:0) after 1m0s
[01:27:27.873] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:51:0)
[01:27:27.873] Timer tick, asking Buildbucket for the build status
[01:27:28.176] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:28.176] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:52:0) after 1m0s
[01:28:28.190] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:52:0)
[01:28:28.190] Timer tick, asking Buildbucket for the build status
[01:28:28.377] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:28.377] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:53:0) after 1m0s
[01:29:28.401] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:53:0)
[01:29:28.401] Timer tick, asking Buildbucket for the build status
[01:29:29.803] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:29.803] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:54:0) after 1m0s
[01:30:29.820] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:54:0)
[01:30:29.821] Timer tick, asking Buildbucket for the build status
[01:30:30.227] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:30.227] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:55:0) after 1m0s
[01:31:30.295] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:55:0)
[01:31:30.295] Timer tick, asking Buildbucket for the build status
[01:31:30.557] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:30.557] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:56:0) after 1m0s
[01:32:30.586] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:56:0)
[01:32:30.586] Timer tick, asking Buildbucket for the build status
[01:32:30.760] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:30.760] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:57:0) after 1m0s
[01:33:30.786] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:57:0)
[01:33:30.786] Timer tick, asking Buildbucket for the build status
[01:33:33.368] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:33.368] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:58:0) after 1m0s
[01:34:33.393] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:58:0)
[01:34:33.393] Timer tick, asking Buildbucket for the build status
[01:34:33.535] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:33.535] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:59:0) after 1m0s
[01:35:33.520] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:59:0)
[01:35:33.520] Timer tick, asking Buildbucket for the build status
[01:35:33.756] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:33.756] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:60:0) after 1m0s
[01:36:33.815] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:60:0)
[01:36:33.815] Timer tick, asking Buildbucket for the build status
[01:36:34.011] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:34.011] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:61:0) after 1m0s
[01:37:34.053] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:61:0)
[01:37:34.053] Timer tick, asking Buildbucket for the build status
[01:37:34.315] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:34.315] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:62:0) after 1m0s
[01:38:34.354] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:62:0)
[01:38:34.354] Timer tick, asking Buildbucket for the build status
[01:38:35.206] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:35.206] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:63:0) after 1m0s
[01:39:35.237] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:63:0)
[01:39:35.237] Timer tick, asking Buildbucket for the build status
[01:39:35.334] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:35.334] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:64:0) after 1m0s
[01:40:35.406] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:64:0)
[01:40:35.406] Timer tick, asking Buildbucket for the build status
[01:40:35.540] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:35.540] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:65:0) after 1m0s
[01:41:35.621] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:65:0)
[01:41:35.621] Timer tick, asking Buildbucket for the build status
[01:41:35.874] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:35.874] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:66:0) after 1m0s
[01:42:35.938] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:66:0)
[01:42:35.938] Timer tick, asking Buildbucket for the build status
[01:42:36.078] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:36.078] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:67:0) after 1m0s
[01:43:36.542] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:67:0)
[01:43:36.542] Timer tick, asking Buildbucket for the build status
[01:43:37.450] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:37.450] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:68:0) after 1m0s
[01:44:37.790] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:68:0)
[01:44:37.790] Timer tick, asking Buildbucket for the build status
[01:44:38.224] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:38.225] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:69:0) after 1m0s
[01:45:38.488] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:69:0)
[01:45:38.488] Timer tick, asking Buildbucket for the build status
[01:45:38.589] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:38.589] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:70:0) after 1m0s
[01:46:38.770] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:70:0)
[01:46:38.770] Timer tick, asking Buildbucket for the build status
[01:46:39.158] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:39.158] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:71:0) after 1m0s
[01:47:39.406] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:71:0)
[01:47:39.406] Timer tick, asking Buildbucket for the build status
[01:47:39.771] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:39.771] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:72:0) after 1m0s
[01:48:39.831] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:72:0)
[01:48:39.831] Timer tick, asking Buildbucket for the build status
[01:48:41.403] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:41.403] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:73:0) after 1m0s
[01:49:41.665] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:73:0)
[01:49:41.665] Timer tick, asking Buildbucket for the build status
[01:49:41.767] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:41.767] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:74:0) after 1m0s
[01:50:41.870] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:74:0)
[01:50:41.870] Timer tick, asking Buildbucket for the build status
[01:50:41.990] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:41.990] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:75:0) after 1m0s
[01:51:42.106] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:75:0)
[01:51:42.106] Timer tick, asking Buildbucket for the build status
[01:51:42.964] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:42.964] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:76:0) after 1m0s
[01:52:43.044] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:76:0)
[01:52:43.044] Timer tick, asking Buildbucket for the build status
[01:52:43.216] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:43.216] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:77:0) after 1m0s
[01:53:43.317] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:77:0)
[01:53:43.317] Timer tick, asking Buildbucket for the build status
[01:53:46.340] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:46.340] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:78:0) after 1m0s
[01:54:46.375] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:78:0)
[01:54:46.375] Timer tick, asking Buildbucket for the build status
[01:54:47.036] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:47.036] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:79:0) after 1m0s
[01:55:47.079] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:79:0)
[01:55:47.079] Timer tick, asking Buildbucket for the build status
[01:55:47.813] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:47.813] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:80:0) after 1m0s
[01:56:47.876] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:80:0)
[01:56:47.876] Timer tick, asking Buildbucket for the build status
[01:56:48.135] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:48.135] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:81:0) after 1m0s
[01:57:48.205] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:81:0)
[01:57:48.205] Timer tick, asking Buildbucket for the build status
[01:57:48.760] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:48.760] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:82:0) after 1m0s
[01:58:48.785] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:82:0)
[01:58:48.785] Timer tick, asking Buildbucket for the build status
[01:58:50.802] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:50.802] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:83:0) after 1m0s
[01:59:50.823] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:83:0)
[01:59:50.823] Timer tick, asking Buildbucket for the build status
[01:59:50.973] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:50.973] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:84:0) after 1m0s
[02:00:50.995] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:84:0)
[02:00:50.995] Timer tick, asking Buildbucket for the build status
[02:00:51.172] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:51.172] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:85:0) after 1m0s
[02:01:51.196] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:85:0)
[02:01:51.196] Timer tick, asking Buildbucket for the build status
[02:01:52.044] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:52.044] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:86:0) after 1m0s
[02:02:52.060] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:86:0)
[02:02:52.060] Timer tick, asking Buildbucket for the build status
[02:02:52.217] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:52.217] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:87:0) after 1m0s
[02:03:52.270] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:87:0)
[02:03:52.270] Timer tick, asking Buildbucket for the build status
[02:03:53.583] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:53.583] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:88:0) after 1m0s
[02:04:53.632] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:88:0)
[02:04:53.632] Timer tick, asking Buildbucket for the build status
[02:04:53.778] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:53.778] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:89:0) after 1m0s
[02:05:53.808] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:89:0)
[02:05:53.808] Timer tick, asking Buildbucket for the build status
[02:05:54.094] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:54.094] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:90:0) after 1m0s
[02:06:54.074] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:90:0)
[02:06:54.074] Timer tick, asking Buildbucket for the build status
[02:06:54.325] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:54.325] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:91:0) after 1m0s
[02:07:54.419] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:91:0)
[02:07:54.419] Timer tick, asking Buildbucket for the build status
[02:07:54.655] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:54.655] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:92:0) after 1m0s
[02:08:54.718] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:92:0)
[02:08:54.718] Timer tick, asking Buildbucket for the build status
[02:08:55.241] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:55.241] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:93:0) after 1m0s
[02:09:55.271] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:93:0)
[02:09:55.271] Timer tick, asking Buildbucket for the build status
[02:09:55.589] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:55.589] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:94:0) after 1m0s
[02:10:55.690] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:94:0)
[02:10:55.690] Timer tick, asking Buildbucket for the build status
[02:10:55.855] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:55.855] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:95:0) after 1m0s
[02:11:55.985] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:95:0)
[02:11:55.985] Timer tick, asking Buildbucket for the build status
[02:11:56.697] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:56.697] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:96:0) after 1m0s
[02:12:56.684] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:96:0)
[02:12:56.684] Timer tick, asking Buildbucket for the build status
[02:12:57.259] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:57.259] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:97:0) after 1m0s
[02:13:57.274] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:97:0)
[02:13:57.274] Timer tick, asking Buildbucket for the build status
[02:13:58.451] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:58.451] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:98:0) after 1m0s
[02:14:58.582] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:98:0)
[02:14:58.582] Timer tick, asking Buildbucket for the build status
[02:14:58.701] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:58.702] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:99:0) after 1m0s
[02:15:58.787] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:99:0)
[02:15:58.787] Timer tick, asking Buildbucket for the build status
[02:15:59.160] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:59.161] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:100:0) after 1m0s
[02:16:59.378] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:100:0)
[02:16:59.378] Timer tick, asking Buildbucket for the build status
[02:16:59.579] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:59.579] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:101:0) after 1m0s
[02:17:59.725] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:101:0)
[02:17:59.725] Timer tick, asking Buildbucket for the build status
[02:17:59.843] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:59.843] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:102:0) after 1m0s
[02:18:59.915] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:102:0)
[02:18:59.915] Timer tick, asking Buildbucket for the build status
[02:19:00.605] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:00.605] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:103:0) after 1m0s
[02:20:01.999] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:103:0)
[02:20:01.999] Timer tick, asking Buildbucket for the build status
[02:20:02.265] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:02.265] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:104:0) after 1m0s
[02:21:02.800] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:104:0)
[02:21:02.800] Timer tick, asking Buildbucket for the build status
[02:21:02.923] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:02.923] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:105:0) after 1m0s
[02:22:03.089] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:105:0)
[02:22:03.089] Timer tick, asking Buildbucket for the build status
[02:22:03.383] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:03.383] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:106:0) after 1m0s
[02:23:03.465] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:106:0)
[02:23:03.465] Timer tick, asking Buildbucket for the build status
[02:23:03.600] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:03.600] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:107:0) after 1m0s
[02:24:03.704] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:107:0)
[02:24:03.704] Timer tick, asking Buildbucket for the build status
[02:24:03.988] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:03.988] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:108:0) after 1m0s
[02:25:04.089] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:108:0)
[02:25:04.089] Timer tick, asking Buildbucket for the build status
[02:25:04.247] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:04.247] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:109:0) after 1m0s
[02:26:05.127] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:109:0)
[02:26:05.127] Timer tick, asking Buildbucket for the build status
[02:26:05.291] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:05.292] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:110:0) after 1m0s
[02:27:05.698] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:110:0)
[02:27:05.698] Timer tick, asking Buildbucket for the build status
[02:27:06.051] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:06.051] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:111:0) after 1m0s
[02:28:06.194] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:111:0)
[02:28:06.194] Timer tick, asking Buildbucket for the build status
[02:28:06.462] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:06.462] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:112:0) after 1m0s
[02:29:06.588] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:112:0)
[02:29:06.588] Timer tick, asking Buildbucket for the build status
[02:29:06.999] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:06.999] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:113:0) after 1m0s
[02:30:07.227] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:113:0)
[02:30:07.227] Timer tick, asking Buildbucket for the build status
[02:30:07.376] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:07.376] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:114:0) after 1m0s
[02:31:07.576] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:114:0)
[02:31:07.576] Timer tick, asking Buildbucket for the build status
[02:31:07.800] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:07.800] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:115:0) after 1m0s
[02:32:07.836] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:115:0)
[02:32:07.836] Timer tick, asking Buildbucket for the build status
[02:32:07.980] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:07.980] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:116:0) after 1m0s
[02:33:08.192] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:116:0)
[02:33:08.192] Timer tick, asking Buildbucket for the build status
[02:33:08.373] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:08.373] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:117:0) after 1m0s
[02:34:08.398] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:117:0)
[02:34:08.398] Timer tick, asking Buildbucket for the build status
[02:34:08.545] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:08.545] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:118:0) after 1m0s
[02:35:08.713] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:118:0)
[02:35:08.713] Timer tick, asking Buildbucket for the build status
[02:35:08.973] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:08.973] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:119:0) after 1m0s
[02:36:09.037] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:119:0)
[02:36:09.037] Timer tick, asking Buildbucket for the build status
[02:36:09.207] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:09.207] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:120:0) after 1m0s
[02:37:09.238] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:120:0)
[02:37:09.238] Timer tick, asking Buildbucket for the build status
[02:37:09.383] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:09.383] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:121:0) after 1m0s
[02:38:09.504] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:121:0)
[02:38:09.504] Timer tick, asking Buildbucket for the build status
[02:38:09.688] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:09.688] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:122:0) after 1m0s
[02:39:09.707] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:122:0)
[02:39:09.707] Timer tick, asking Buildbucket for the build status
[02:39:09.952] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:09.952] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:123:0) after 1m0s
[02:40:10.102] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:123:0)
[02:40:10.102] Timer tick, asking Buildbucket for the build status
[02:40:10.246] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:10.246] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:124:0) after 1m0s
[02:41:10.352] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:124:0)
[02:41:10.352] Timer tick, asking Buildbucket for the build status
[02:41:10.475] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:10.475] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:125:0) after 1m0s
[02:42:10.545] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:125:0)
[02:42:10.545] Timer tick, asking Buildbucket for the build status
[02:42:11.401] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:11.401] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:126:0) after 1m0s
[02:43:11.460] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:126:0)
[02:43:11.460] Timer tick, asking Buildbucket for the build status
[02:43:11.565] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:11.565] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:127:0) after 1m0s
[02:44:11.630] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:127:0)
[02:44:11.630] Timer tick, asking Buildbucket for the build status
[02:44:12.298] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:12.298] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:128:0) after 1m0s
[02:45:13.196] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:128:0)
[02:45:13.196] Timer tick, asking Buildbucket for the build status
[02:45:13.430] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:13.430] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:129:0) after 1m0s
[02:46:14.449] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:129:0)
[02:46:14.449] Timer tick, asking Buildbucket for the build status
[02:46:14.683] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:14.683] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:130:0) after 1m0s
[02:47:14.681] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:130:0)
[02:47:14.681] Timer tick, asking Buildbucket for the build status
[02:47:14.845] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:14.845] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:131:0) after 1m0s
[02:48:14.936] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:131:0)
[02:48:14.936] Timer tick, asking Buildbucket for the build status
[02:48:15.149] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:15.149] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:132:0) after 1m0s
[02:49:15.248] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:132:0)
[02:49:15.248] Timer tick, asking Buildbucket for the build status
[02:49:15.641] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:15.641] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:133:0) after 1m0s
[02:50:15.722] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:133:0)
[02:50:15.722] Timer tick, asking Buildbucket for the build status
[02:50:15.843] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:15.843] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:134:0) after 1m0s
[02:51:15.922] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:134:0)
[02:51:15.922] Timer tick, asking Buildbucket for the build status
[02:51:16.078] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:16.078] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:135:0) after 1m0s
[02:52:16.171] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:135:0)
[02:52:16.171] Timer tick, asking Buildbucket for the build status
[02:52:16.483] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:16.483] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:136:0) after 1m0s
[02:53:16.614] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:136:0)
[02:53:16.615] Timer tick, asking Buildbucket for the build status
[02:53:16.850] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:53:16.850] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:137:0) after 1m0s
[02:54:17.009] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:137:0)
[02:54:17.009] Timer tick, asking Buildbucket for the build status
[02:54:17.492] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:54:17.492] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:138:0) after 1m0s
[02:55:17.640] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:138:0)
[02:55:17.640] Timer tick, asking Buildbucket for the build status
[02:55:17.848] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:55:17.848] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:139:0) after 1m0s
[02:56:17.954] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:139:0)
[02:56:17.954] Timer tick, asking Buildbucket for the build status
[02:56:18.381] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:56:18.381] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:140:0) after 1m0s
[02:57:18.401] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:140:0)
[02:57:18.401] Timer tick, asking Buildbucket for the build status
[02:57:18.592] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:57:18.592] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:141:0) after 1m0s
[02:58:18.689] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:141:0)
[02:58:18.689] Timer tick, asking Buildbucket for the build status
[02:58:19.696] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:58:19.696] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:142:0) after 1m0s
[02:59:19.769] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:142:0)
[02:59:19.769] Timer tick, asking Buildbucket for the build status
[02:59:19.896] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:59:19.897] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:143:0) after 1m0s
[03:00:19.922] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:143:0)
[03:00:19.922] Timer tick, asking Buildbucket for the build status
[03:00:20.431] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:00:20.431] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:144:0) after 1m0s
[03:01:20.508] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:144:0)
[03:01:20.508] Timer tick, asking Buildbucket for the build status
[03:01:20.798] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:20.798] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:145:0) after 1m0s
[03:02:20.884] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:145:0)
[03:02:20.884] Timer tick, asking Buildbucket for the build status
[03:02:21.120] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:21.120] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:146:0) after 1m0s
[03:03:21.236] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:146:0)
[03:03:21.236] Timer tick, asking Buildbucket for the build status
[03:03:22.851] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:03:22.851] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:147:0) after 1m0s
[03:04:22.942] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:147:0)
[03:04:22.942] Timer tick, asking Buildbucket for the build status
[03:04:23.115] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:04:23.115] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:148:0) after 1m0s
[03:05:23.150] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:148:0)
[03:05:23.150] Timer tick, asking Buildbucket for the build status
[03:05:23.441] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:05:23.441] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:149:0) after 1m0s
[03:06:23.506] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:149:0)
[03:06:23.506] Timer tick, asking Buildbucket for the build status
[03:06:23.700] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:06:23.700] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:150:0) after 1m0s
[03:07:23.730] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:150:0)
[03:07:23.730] Timer tick, asking Buildbucket for the build status
[03:07:23.901] Build 8876745710634819216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:07:23.901] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9042175773652837584:151:0) after 1m0s
[03:07:38.632] Received PubSub notification, asking Buildbucket for the build status
[03:07:38.792] Build 8876745710634819216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:14.492] Received PubSub notification, asking Buildbucket for the build status
[03:08:14.578] Build 8876745710634819216: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:08:14.578] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1592881693624924",
"created_by": "project:infra",
"created_ts": "1592872624706199",
"id": "8876745710634819216",
"parameters_json": "{\"builder_name\": \"publish_tarball_dispatcher\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"11046\"}, \"id\": \"cron:v1:11046\"}]}}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_b136a1c49c74fd832625137d469d90163c6f70564fe4999249905c86add33f53_v2\", \"builder_ca1dd8081634cfdf63cf6543806b7419b3e097f184142241b02f8854d1768d0b_v2\", \"builder_dbab9abe7188467828c33829af37b0f6a86a533613509fd8bbd879beea667f22_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-medium-0-plno\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5218-123b763\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1592881657321957",
"status": "COMPLETED",
"status_changed_ts": "1592881694167077",
"tags": [
"builder:publish_tarball_dispatcher",
"scheduler_invocation_id:9042175773652837584",
"scheduler_job_id:infra/publish_tarball_dispatcher",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8876745710634819216/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:publish_tarball",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_task_id:4cf76cfe3ae0be10",
"user_agent:luci-scheduler"
],
"updated_ts": "1592881694174834",
"url": "https://ci.chromium.org/b/8876745710634819216",
"utcnow_ts": "1592881694569554"
}
}
[03:08:14.578] Invocation finished in 2h31m12.134205432s with status SUCCEEDED