[12:37:04.793] New invocation is queued and will start shortly
[12:37:09.015] Starting the invocation (attempt 1)
[12:37:09.174] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:37:09.178] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:37:09.178] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9049197036107223504",
"parameters_json": "{\"builder_name\":\"publish_tarball_dispatcher\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"cron\":{\"generation\":\"9186\"},\"id\":\"cron:v1:9186\"}]}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:publish_tarball_dispatcher",
"scheduler_invocation_id:9049197036107223504",
"scheduler_job_id:infra/publish_tarball_dispatcher",
"user_agent:luci-scheduler"
]
}
[12:37:10.864] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1586176629311830",
"id": "8883766970702093168",
"parameters_json": "{\"builder_name\": \"publish_tarball_dispatcher\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"9186\"}, \"id\": \"cron:v1:9186\"}]}}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1586176630414914",
"tags": [
"builder:publish_tarball_dispatcher",
"scheduler_invocation_id:9049197036107223504",
"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/8883766970702093168/+/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": "1586176630415068",
"url": "https://ci.chromium.org/b/8883766970702093168",
"utcnow_ts": "1586176630813398"
}
}
[12:37:10.864] Task URL: https://ci.chromium.org/b/8883766970702093168
[12:37:10.864] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:2:0) after 1m0s
[12:38:10.991] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:2:0)
[12:38:10.991] Timer tick, asking Buildbucket for the build status
[12:38:11.356] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:38:11.356] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:3:0) after 1m0s
[12:39:11.392] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:3:0)
[12:39:11.392] Timer tick, asking Buildbucket for the build status
[12:39:11.758] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:39:11.758] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:4:0) after 1m0s
[12:40:11.796] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:4:0)
[12:40:11.796] Timer tick, asking Buildbucket for the build status
[12:40:11.938] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:40:11.938] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:5:0) after 1m0s
[12:41:11.954] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:5:0)
[12:41:11.954] Timer tick, asking Buildbucket for the build status
[12:41:12.075] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:41:12.075] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:6:0) after 1m0s
[12:42:12.187] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:6:0)
[12:42:12.187] Timer tick, asking Buildbucket for the build status
[12:42:12.426] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:42:12.426] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:7:0) after 1m0s
[12:43:12.452] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:7:0)
[12:43:12.452] Timer tick, asking Buildbucket for the build status
[12:43:12.768] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:43:12.768] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:8:0) after 1m0s
[12:44:12.786] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:8:0)
[12:44:12.786] Timer tick, asking Buildbucket for the build status
[12:44:12.938] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:44:12.938] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:9:0) after 1m0s
[12:45:12.978] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:9:0)
[12:45:12.978] Timer tick, asking Buildbucket for the build status
[12:45:13.150] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:45:13.150] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:10:0) after 1m0s
[12:46:13.219] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:10:0)
[12:46:13.219] Timer tick, asking Buildbucket for the build status
[12:46:13.348] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:46:13.348] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:11:0) after 1m0s
[12:47:13.402] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:11:0)
[12:47:13.402] Timer tick, asking Buildbucket for the build status
[12:47:13.632] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:47:13.632] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:12:0) after 1m0s
[12:48:13.675] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:12:0)
[12:48:13.675] Timer tick, asking Buildbucket for the build status
[12:48:14.165] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:48:14.165] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:13:0) after 1m0s
[12:49:14.196] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:13:0)
[12:49:14.196] Timer tick, asking Buildbucket for the build status
[12:49:14.672] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:49:14.672] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:14:0) after 1m0s
[12:50:14.825] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:14:0)
[12:50:14.825] Timer tick, asking Buildbucket for the build status
[12:50:15.017] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:50:15.017] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:15:0) after 1m0s
[12:51:15.076] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:15:0)
[12:51:15.076] Timer tick, asking Buildbucket for the build status
[12:51:15.428] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:51:15.428] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:16:0) after 1m0s
[12:52:15.598] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:16:0)
[12:52:15.599] Timer tick, asking Buildbucket for the build status
[12:52:15.941] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:52:15.941] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:17:0) after 1m0s
[12:53:16.051] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:17:0)
[12:53:16.051] Timer tick, asking Buildbucket for the build status
[12:53:16.259] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:53:16.259] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:18:0) after 1m0s
[12:54:16.296] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:18:0)
[12:54:16.296] Timer tick, asking Buildbucket for the build status
[12:54:16.441] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:54:16.441] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:19:0) after 1m0s
[12:55:16.505] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:19:0)
[12:55:16.505] Timer tick, asking Buildbucket for the build status
[12:55:16.731] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:55:16.731] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:20:0) after 1m0s
[12:56:16.808] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:20:0)
[12:56:16.808] Timer tick, asking Buildbucket for the build status
[12:56:16.945] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:56:16.945] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:21:0) after 1m0s
[12:57:17.038] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:21:0)
[12:57:17.038] Timer tick, asking Buildbucket for the build status
[12:57:17.379] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:57:17.379] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:22:0) after 1m0s
[12:58:17.398] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:22:0)
[12:58:17.398] Timer tick, asking Buildbucket for the build status
[12:58:17.526] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:58:17.526] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:23:0) after 1m0s
[12:59:17.548] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:23:0)
[12:59:17.548] Timer tick, asking Buildbucket for the build status
[12:59:17.961] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:59:17.961] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:24:0) after 1m0s
[13:00:18.022] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:24:0)
[13:00:18.022] Timer tick, asking Buildbucket for the build status
[13:00:18.438] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:00:18.438] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:25:0) after 1m0s
[13:01:18.455] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:25:0)
[13:01:18.455] Timer tick, asking Buildbucket for the build status
[13:01:18.613] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:01:18.613] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:26:0) after 1m0s
[13:02:18.650] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:26:0)
[13:02:18.650] Timer tick, asking Buildbucket for the build status
[13:02:19.028] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:02:19.028] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:27:0) after 1m0s
[13:03:19.093] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:27:0)
[13:03:19.093] Timer tick, asking Buildbucket for the build status
[13:03:19.242] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:03:19.242] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:28:0) after 1m0s
[13:04:19.216] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:28:0)
[13:04:19.216] Timer tick, asking Buildbucket for the build status
[13:04:19.477] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:04:19.477] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:29:0) after 1m0s
[13:05:19.549] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:29:0)
[13:05:19.549] Timer tick, asking Buildbucket for the build status
[13:05:19.642] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:05:19.642] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:30:0) after 1m0s
[13:06:19.678] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:30:0)
[13:06:19.678] Timer tick, asking Buildbucket for the build status
[13:06:20.049] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:06:20.049] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:31:0) after 1m0s
[13:07:20.084] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:31:0)
[13:07:20.084] Timer tick, asking Buildbucket for the build status
[13:07:20.764] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:07:20.764] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:32:0) after 1m0s
[13:08:20.784] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:32:0)
[13:08:20.784] Timer tick, asking Buildbucket for the build status
[13:08:20.891] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:08:20.891] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:33:0) after 1m0s
[13:09:20.914] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:33:0)
[13:09:20.914] Timer tick, asking Buildbucket for the build status
[13:09:21.063] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:09:21.063] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:34:0) after 1m0s
[13:10:21.124] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:34:0)
[13:10:21.124] Timer tick, asking Buildbucket for the build status
[13:10:21.373] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:10:21.373] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:35:0) after 1m0s
[13:11:21.391] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:35:0)
[13:11:21.391] Timer tick, asking Buildbucket for the build status
[13:11:21.565] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:11:21.565] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:36:0) after 1m0s
[13:12:21.567] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:36:0)
[13:12:21.567] Timer tick, asking Buildbucket for the build status
[13:12:21.720] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:12:21.720] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:37:0) after 1m0s
[13:13:21.744] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:37:0)
[13:13:21.744] Timer tick, asking Buildbucket for the build status
[13:13:21.866] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:13:21.866] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:38:0) after 1m0s
[13:14:21.843] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:38:0)
[13:14:21.843] Timer tick, asking Buildbucket for the build status
[13:14:22.082] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:14:22.082] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:39:0) after 1m0s
[13:15:22.131] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:39:0)
[13:15:22.131] Timer tick, asking Buildbucket for the build status
[13:15:22.231] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:15:22.231] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:40:0) after 1m0s
[13:16:22.268] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:40:0)
[13:16:22.268] Timer tick, asking Buildbucket for the build status
[13:16:22.571] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:16:22.572] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:41:0) after 1m0s
[13:17:22.612] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:41:0)
[13:17:22.613] Timer tick, asking Buildbucket for the build status
[13:17:22.727] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:17:22.727] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:42:0) after 1m0s
[13:18:22.784] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:42:0)
[13:18:22.784] Timer tick, asking Buildbucket for the build status
[13:18:23.056] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:18:23.056] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:43:0) after 1m0s
[13:19:23.069] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:43:0)
[13:19:23.069] Timer tick, asking Buildbucket for the build status
[13:19:23.324] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:19:23.324] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:44:0) after 1m0s
[13:20:23.313] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:44:0)
[13:20:23.313] Timer tick, asking Buildbucket for the build status
[13:20:23.486] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:20:23.486] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:45:0) after 1m0s
[13:21:23.505] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:45:0)
[13:21:23.505] Timer tick, asking Buildbucket for the build status
[13:21:23.695] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:21:23.695] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:46:0) after 1m0s
[13:22:23.761] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:46:0)
[13:22:23.761] Timer tick, asking Buildbucket for the build status
[13:22:23.869] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:22:23.869] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:47:0) after 1m0s
[13:23:23.874] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:47:0)
[13:23:23.874] Timer tick, asking Buildbucket for the build status
[13:23:24.461] Build 8883766970702093168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:23:24.461] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9049197036107223504:48:0) after 1m0s
[13:23:28.891] Received PubSub notification, asking Buildbucket for the build status
[13:23:29.162] Build 8883766970702093168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:15.015] Received PubSub notification, asking Buildbucket for the build status
[13:24:15.188] Build 8883766970702093168: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:24:15.188] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1586179453912759",
"created_by": "project:infra",
"created_ts": "1586176629311830",
"id": "8883766970702093168",
"parameters_json": "{\"builder_name\": \"publish_tarball_dispatcher\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"9186\"}, \"id\": \"cron:v1:9186\"}]}}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"9186\"}, \"id\": \"cron:v1:9186\"}]}, \"bot_id\": \"luci-infra-cron-xenial-medium-1-x0re\", \"buildername\": \"publish_tarball_dispatcher\", \"path_config\": \"generic\", \"recipe\": \"publish_tarball\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_b136a1c49c74fd832625137d469d90163c6f70564fe4999249905c86add33f53_v2\", \"git\", \"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-1-x0re\"], \"image\": [\"chrome-xenial-20040500-42c1ff87780\"], \"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\": [\"4926-84b94b1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1586179408223875",
"status": "COMPLETED",
"status_changed_ts": "1586179454592871",
"tags": [
"builder:publish_tarball_dispatcher",
"scheduler_invocation_id:9049197036107223504",
"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/8883766970702093168/+/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:4b6850286c781410",
"user_agent:luci-scheduler"
],
"updated_ts": "1586179454608324",
"url": "https://ci.chromium.org/b/8883766970702093168",
"utcnow_ts": "1586179455179944"
}
}
[13:24:15.188] Invocation finished in 47m10.415707189s with status SUCCEEDED