[01:50:59.061] New invocation is queued and will start shortly
[01:50:59.061] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[01:51:00.170] Starting the invocation (attempt 1)
[01:51:00.232] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:51:00.232] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:51:00.232] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9026679040285513296",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"89.0.4350.5\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"bc9f868e-d5dc-4c5b-a1a1-0a5fcf71d526\",\"title\":\"publish_tarball/0\"}]},\"version\":\"89.0.4350.5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9026679040285513296",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[01:51:00.731] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1607651460371261",
"id": "8861248978247817104",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"89.0.4350.5\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"bc9f868e-d5dc-4c5b-a1a1-0a5fcf71d526\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"89.0.4350.5\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607651460581925",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9026679040285513296",
"scheduler_job_id:infra/Build From Tarball",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8861248978247817104/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:recipe_name:build_from_tarball",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_task_id:",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1607651460582044",
"url": "https://ci.chromium.org/b/8861248978247817104",
"utcnow_ts": "1607651460712969"
}
}
[01:51:00.731] Task URL: https://ci.chromium.org/b/8861248978247817104
[01:51:00.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:2:0) after 1m0s
[01:51:22.814] Received PubSub notification, asking Buildbucket for the build status
[01:51:22.905] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:00.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:2:0)
[01:52:00.872] Timer tick, asking Buildbucket for the build status
[01:52:00.990] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:00.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:4:0) after 1m0s
[01:53:01.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:4:0)
[01:53:01.194] Timer tick, asking Buildbucket for the build status
[01:53:01.286] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:01.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:5:0) after 1m0s
[01:54:01.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:5:0)
[01:54:01.309] Timer tick, asking Buildbucket for the build status
[01:54:02.279] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:02.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:6:0) after 1m0s
[01:55:02.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:6:0)
[01:55:02.385] Timer tick, asking Buildbucket for the build status
[01:55:02.533] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:02.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:7:0) after 1m0s
[01:56:02.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:7:0)
[01:56:02.536] Timer tick, asking Buildbucket for the build status
[01:56:02.636] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:02.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:8:0) after 1m0s
[01:57:02.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:8:0)
[01:57:02.704] Timer tick, asking Buildbucket for the build status
[01:57:02.758] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:02.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:9:0) after 1m0s
[01:58:02.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:9:0)
[01:58:02.823] Timer tick, asking Buildbucket for the build status
[01:58:02.927] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:02.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:10:0) after 1m0s
[01:59:03.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:10:0)
[01:59:03.088] Timer tick, asking Buildbucket for the build status
[01:59:03.335] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:03.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:11:0) after 1m0s
[02:00:03.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:11:0)
[02:00:03.460] Timer tick, asking Buildbucket for the build status
[02:00:03.549] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:03.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:12:0) after 1m0s
[02:01:03.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:12:0)
[02:01:03.544] Timer tick, asking Buildbucket for the build status
[02:01:03.861] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:03.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:13:0) after 1m0s
[02:02:04.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:13:0)
[02:02:04.016] Timer tick, asking Buildbucket for the build status
[02:02:04.236] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:04.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:14:0) after 1m0s
[02:03:04.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:14:0)
[02:03:04.293] Timer tick, asking Buildbucket for the build status
[02:03:04.536] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:04.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:15:0) after 1m0s
[02:04:04.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:15:0)
[02:04:04.563] Timer tick, asking Buildbucket for the build status
[02:04:04.635] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:04.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:16:0) after 1m0s
[02:05:04.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:16:0)
[02:05:04.731] Timer tick, asking Buildbucket for the build status
[02:05:04.961] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:04.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:17:0) after 1m0s
[02:06:04.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:17:0)
[02:06:04.967] Timer tick, asking Buildbucket for the build status
[02:06:05.696] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:05.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:18:0) after 1m0s
[02:07:05.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:18:0)
[02:07:05.784] Timer tick, asking Buildbucket for the build status
[02:07:05.884] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:05.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:19:0) after 1m0s
[02:08:05.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:19:0)
[02:08:05.915] Timer tick, asking Buildbucket for the build status
[02:08:06.127] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:06.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:20:0) after 1m0s
[02:09:06.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:20:0)
[02:09:06.162] Timer tick, asking Buildbucket for the build status
[02:09:06.373] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:06.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:21:0) after 1m0s
[02:10:06.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:21:0)
[02:10:06.368] Timer tick, asking Buildbucket for the build status
[02:10:06.472] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:06.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:22:0) after 1m0s
[02:11:06.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:22:0)
[02:11:06.495] Timer tick, asking Buildbucket for the build status
[02:11:06.670] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:06.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:23:0) after 1m0s
[02:12:06.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:23:0)
[02:12:06.705] Timer tick, asking Buildbucket for the build status
[02:12:06.937] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:06.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:24:0) after 1m0s
[02:13:07.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:24:0)
[02:13:07.013] Timer tick, asking Buildbucket for the build status
[02:13:07.247] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:07.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:25:0) after 1m0s
[02:14:07.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:25:0)
[02:14:07.278] Timer tick, asking Buildbucket for the build status
[02:14:07.366] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:07.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:26:0) after 1m0s
[02:15:07.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:26:0)
[02:15:07.393] Timer tick, asking Buildbucket for the build status
[02:15:07.523] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:07.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:27:0) after 1m0s
[02:16:07.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:27:0)
[02:16:07.564] Timer tick, asking Buildbucket for the build status
[02:16:08.063] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:08.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:28:0) after 1m0s
[02:17:08.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:28:0)
[02:17:08.084] Timer tick, asking Buildbucket for the build status
[02:17:08.141] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:08.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:29:0) after 1m0s
[02:18:08.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:29:0)
[02:18:08.164] Timer tick, asking Buildbucket for the build status
[02:18:08.241] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:08.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:30:0) after 1m0s
[02:19:08.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:30:0)
[02:19:08.265] Timer tick, asking Buildbucket for the build status
[02:19:08.358] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:08.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:31:0) after 1m0s
[02:20:08.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:31:0)
[02:20:08.381] Timer tick, asking Buildbucket for the build status
[02:20:08.502] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:08.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:32:0) after 1m0s
[02:21:08.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:32:0)
[02:21:08.597] Timer tick, asking Buildbucket for the build status
[02:21:08.721] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:08.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:33:0) after 1m0s
[02:22:08.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:33:0)
[02:22:08.749] Timer tick, asking Buildbucket for the build status
[02:22:08.899] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:08.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:34:0) after 1m0s
[02:23:08.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:34:0)
[02:23:08.892] Timer tick, asking Buildbucket for the build status
[02:23:09.000] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:09.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:35:0) after 1m0s
[02:24:09.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:35:0)
[02:24:09.008] Timer tick, asking Buildbucket for the build status
[02:24:09.112] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:09.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:36:0) after 1m0s
[02:25:09.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:36:0)
[02:25:09.214] Timer tick, asking Buildbucket for the build status
[02:25:09.412] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:09.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:37:0) after 1m0s
[02:26:09.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:37:0)
[02:26:09.438] Timer tick, asking Buildbucket for the build status
[02:26:09.597] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:09.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:38:0) after 1m0s
[02:27:09.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:38:0)
[02:27:09.651] Timer tick, asking Buildbucket for the build status
[02:27:09.747] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:09.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:39:0) after 1m0s
[02:28:09.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:39:0)
[02:28:09.724] Timer tick, asking Buildbucket for the build status
[02:28:09.800] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:09.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:40:0) after 1m0s
[02:29:09.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:40:0)
[02:29:09.881] Timer tick, asking Buildbucket for the build status
[02:29:10.252] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:10.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:41:0) after 1m0s
[02:30:10.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:41:0)
[02:30:10.337] Timer tick, asking Buildbucket for the build status
[02:30:10.409] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:10.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:42:0) after 1m0s
[02:31:10.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:42:0)
[02:31:10.503] Timer tick, asking Buildbucket for the build status
[02:31:10.634] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:10.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:43:0) after 1m0s
[02:32:10.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:43:0)
[02:32:10.620] Timer tick, asking Buildbucket for the build status
[02:32:10.695] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:10.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:44:0) after 1m0s
[02:33:10.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:44:0)
[02:33:10.833] Timer tick, asking Buildbucket for the build status
[02:33:10.899] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:10.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:45:0) after 1m0s
[02:34:11.050] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:45:0)
[02:34:11.050] Timer tick, asking Buildbucket for the build status
[02:34:11.121] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:11.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:46:0) after 1m0s
[02:35:11.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:46:0)
[02:35:11.188] Timer tick, asking Buildbucket for the build status
[02:35:11.270] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:11.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:47:0) after 1m0s
[02:36:11.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:47:0)
[02:36:11.356] Timer tick, asking Buildbucket for the build status
[02:36:11.508] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:11.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:48:0) after 1m0s
[02:37:11.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:48:0)
[02:37:11.570] Timer tick, asking Buildbucket for the build status
[02:37:11.827] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:11.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:49:0) after 1m0s
[02:38:12.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:49:0)
[02:38:12.012] Timer tick, asking Buildbucket for the build status
[02:38:12.086] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:12.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:50:0) after 1m0s
[02:39:12.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:50:0)
[02:39:12.284] Timer tick, asking Buildbucket for the build status
[02:39:12.482] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:12.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:51:0) after 1m0s
[02:40:12.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:51:0)
[02:40:12.533] Timer tick, asking Buildbucket for the build status
[02:40:12.612] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:12.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:52:0) after 1m0s
[02:41:12.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:52:0)
[02:41:12.730] Timer tick, asking Buildbucket for the build status
[02:41:12.904] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:12.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:53:0) after 1m0s
[02:42:12.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:53:0)
[02:42:12.931] Timer tick, asking Buildbucket for the build status
[02:42:13.120] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:13.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:54:0) after 1m0s
[02:43:13.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:54:0)
[02:43:13.178] Timer tick, asking Buildbucket for the build status
[02:43:13.285] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:13.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:55:0) after 1m0s
[02:44:13.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:55:0)
[02:44:13.387] Timer tick, asking Buildbucket for the build status
[02:44:13.456] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:13.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:56:0) after 1m0s
[02:45:13.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:56:0)
[02:45:13.480] Timer tick, asking Buildbucket for the build status
[02:45:13.613] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:13.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:57:0) after 1m0s
[02:46:13.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:57:0)
[02:46:13.618] Timer tick, asking Buildbucket for the build status
[02:46:13.725] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:13.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:58:0) after 1m0s
[02:47:13.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:58:0)
[02:47:13.749] Timer tick, asking Buildbucket for the build status
[02:47:13.818] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:13.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:59:0) after 1m0s
[02:48:13.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:59:0)
[02:48:13.842] Timer tick, asking Buildbucket for the build status
[02:48:13.908] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:13.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:60:0) after 1m0s
[02:49:13.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:60:0)
[02:49:13.948] Timer tick, asking Buildbucket for the build status
[02:49:14.022] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:14.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:61:0) after 1m0s
[02:50:14.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:61:0)
[02:50:14.099] Timer tick, asking Buildbucket for the build status
[02:50:14.321] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:14.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:62:0) after 1m0s
[02:51:14.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:62:0)
[02:51:14.384] Timer tick, asking Buildbucket for the build status
[02:51:14.487] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:14.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:63:0) after 1m0s
[02:52:14.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:63:0)
[02:52:14.546] Timer tick, asking Buildbucket for the build status
[02:52:14.819] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:14.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:64:0) after 1m0s
[02:53:14.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:64:0)
[02:53:14.903] Timer tick, asking Buildbucket for the build status
[02:53:15.152] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:15.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:65:0) after 1m0s
[02:54:15.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:65:0)
[02:54:15.225] Timer tick, asking Buildbucket for the build status
[02:54:15.334] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:15.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:66:0) after 1m0s
[02:55:15.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:66:0)
[02:55:15.354] Timer tick, asking Buildbucket for the build status
[02:55:15.455] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:15.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:67:0) after 1m0s
[02:56:15.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:67:0)
[02:56:15.489] Timer tick, asking Buildbucket for the build status
[02:56:15.611] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:15.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:68:0) after 1m0s
[02:57:15.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:68:0)
[02:57:15.614] Timer tick, asking Buildbucket for the build status
[02:57:15.668] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:15.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:69:0) after 1m0s
[02:58:15.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:69:0)
[02:58:15.739] Timer tick, asking Buildbucket for the build status
[02:58:15.888] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:15.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:70:0) after 1m0s
[02:59:15.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:70:0)
[02:59:15.889] Timer tick, asking Buildbucket for the build status
[02:59:16.133] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:16.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:71:0) after 1m0s
[03:00:16.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:71:0)
[03:00:16.204] Timer tick, asking Buildbucket for the build status
[03:00:16.408] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:16.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:72:0) after 1m0s
[03:01:16.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:72:0)
[03:01:16.455] Timer tick, asking Buildbucket for the build status
[03:01:16.841] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:16.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:73:0) after 1m0s
[03:02:16.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:73:0)
[03:02:16.920] Timer tick, asking Buildbucket for the build status
[03:02:17.319] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:17.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:74:0) after 1m0s
[03:03:17.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:74:0)
[03:03:17.348] Timer tick, asking Buildbucket for the build status
[03:03:17.407] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:17.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:75:0) after 1m0s
[03:04:17.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:75:0)
[03:04:17.465] Timer tick, asking Buildbucket for the build status
[03:04:17.533] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:17.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:76:0) after 1m0s
[03:05:17.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:76:0)
[03:05:17.581] Timer tick, asking Buildbucket for the build status
[03:05:17.644] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:17.644] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:77:0) after 1m0s
[03:06:17.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:77:0)
[03:06:17.723] Timer tick, asking Buildbucket for the build status
[03:06:17.873] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:17.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:78:0) after 1m0s
[03:07:17.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:78:0)
[03:07:17.968] Timer tick, asking Buildbucket for the build status
[03:07:18.020] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:18.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:79:0) after 1m0s
[03:08:18.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:79:0)
[03:08:18.096] Timer tick, asking Buildbucket for the build status
[03:08:18.168] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:18.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:80:0) after 1m0s
[03:09:18.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:80:0)
[03:09:18.217] Timer tick, asking Buildbucket for the build status
[03:09:18.310] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:18.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:81:0) after 1m0s
[03:10:18.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:81:0)
[03:10:18.313] Timer tick, asking Buildbucket for the build status
[03:10:18.620] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:18.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:82:0) after 1m0s
[03:11:18.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:82:0)
[03:11:18.671] Timer tick, asking Buildbucket for the build status
[03:11:18.785] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:18.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:83:0) after 1m0s
[03:12:18.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:83:0)
[03:12:18.877] Timer tick, asking Buildbucket for the build status
[03:12:18.972] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:18.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:84:0) after 1m0s
[03:13:18.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:84:0)
[03:13:18.995] Timer tick, asking Buildbucket for the build status
[03:13:19.053] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:19.053] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:85:0) after 1m0s
[03:14:19.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:85:0)
[03:14:19.086] Timer tick, asking Buildbucket for the build status
[03:14:19.501] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:19.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:86:0) after 1m0s
[03:15:19.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:86:0)
[03:15:19.587] Timer tick, asking Buildbucket for the build status
[03:15:19.654] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:19.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:87:0) after 1m0s
[03:16:19.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:87:0)
[03:16:19.695] Timer tick, asking Buildbucket for the build status
[03:16:19.818] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:19.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:88:0) after 1m0s
[03:17:19.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:88:0)
[03:17:19.890] Timer tick, asking Buildbucket for the build status
[03:17:19.979] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:19.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:89:0) after 1m0s
[03:18:20.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:89:0)
[03:18:20.041] Timer tick, asking Buildbucket for the build status
[03:18:20.211] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:20.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:90:0) after 1m0s
[03:19:20.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:90:0)
[03:19:20.243] Timer tick, asking Buildbucket for the build status
[03:19:20.297] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:20.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:91:0) after 1m0s
[03:20:20.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:91:0)
[03:20:20.377] Timer tick, asking Buildbucket for the build status
[03:20:20.548] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:20.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:92:0) after 1m0s
[03:21:20.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:92:0)
[03:21:20.584] Timer tick, asking Buildbucket for the build status
[03:21:20.734] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:20.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:93:0) after 1m0s
[03:22:20.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:93:0)
[03:22:20.852] Timer tick, asking Buildbucket for the build status
[03:22:21.004] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:21.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:94:0) after 1m0s
[03:23:21.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:94:0)
[03:23:21.184] Timer tick, asking Buildbucket for the build status
[03:23:21.410] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:21.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:95:0) after 1m0s
[03:24:21.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:95:0)
[03:24:21.758] Timer tick, asking Buildbucket for the build status
[03:24:21.816] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:21.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:96:0) after 1m0s
[03:25:22.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:96:0)
[03:25:22.110] Timer tick, asking Buildbucket for the build status
[03:25:22.633] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:22.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:97:0) after 1m0s
[03:26:22.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:97:0)
[03:26:22.780] Timer tick, asking Buildbucket for the build status
[03:26:22.869] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:22.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:98:0) after 1m0s
[03:27:24.080] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:98:0)
[03:27:24.080] Timer tick, asking Buildbucket for the build status
[03:27:24.151] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:24.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:99:0) after 1m0s
[03:28:24.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:99:0)
[03:28:24.181] Timer tick, asking Buildbucket for the build status
[03:28:24.249] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:24.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:100:0) after 1m0s
[03:29:24.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:100:0)
[03:29:24.251] Timer tick, asking Buildbucket for the build status
[03:29:24.311] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:24.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:101:0) after 1m0s
[03:30:24.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:101:0)
[03:30:24.386] Timer tick, asking Buildbucket for the build status
[03:30:24.464] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:24.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:102:0) after 1m0s
[03:31:24.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:102:0)
[03:31:24.565] Timer tick, asking Buildbucket for the build status
[03:31:24.666] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:24.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:103:0) after 1m0s
[03:32:24.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:103:0)
[03:32:24.722] Timer tick, asking Buildbucket for the build status
[03:32:24.782] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:24.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:104:0) after 1m0s
[03:33:24.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:104:0)
[03:33:24.825] Timer tick, asking Buildbucket for the build status
[03:33:24.895] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:24.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:105:0) after 1m0s
[03:34:25.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:105:0)
[03:34:25.029] Timer tick, asking Buildbucket for the build status
[03:34:25.303] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:25.303] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:106:0) after 1m0s
[03:35:25.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:106:0)
[03:35:25.329] Timer tick, asking Buildbucket for the build status
[03:35:25.625] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:25.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:107:0) after 1m0s
[03:36:25.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:107:0)
[03:36:25.674] Timer tick, asking Buildbucket for the build status
[03:36:25.781] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:25.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:108:0) after 1m0s
[03:37:25.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:108:0)
[03:37:25.956] Timer tick, asking Buildbucket for the build status
[03:37:26.024] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:26.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:109:0) after 1m0s
[03:38:26.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:109:0)
[03:38:26.141] Timer tick, asking Buildbucket for the build status
[03:38:26.220] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:26.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:110:0) after 1m0s
[03:39:26.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:110:0)
[03:39:26.369] Timer tick, asking Buildbucket for the build status
[03:39:26.460] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:26.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:111:0) after 1m0s
[03:40:26.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:111:0)
[03:40:26.611] Timer tick, asking Buildbucket for the build status
[03:40:26.864] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:26.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:112:0) after 1m0s
[03:41:27.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:112:0)
[03:41:27.045] Timer tick, asking Buildbucket for the build status
[03:41:27.166] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:27.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:113:0) after 1m0s
[03:42:27.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:113:0)
[03:42:27.259] Timer tick, asking Buildbucket for the build status
[03:42:27.322] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:27.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:114:0) after 1m0s
[03:43:27.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:114:0)
[03:43:27.417] Timer tick, asking Buildbucket for the build status
[03:43:27.491] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:27.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:115:0) after 1m0s
[03:44:27.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:115:0)
[03:44:27.515] Timer tick, asking Buildbucket for the build status
[03:44:27.867] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:27.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:116:0) after 1m0s
[03:45:27.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:116:0)
[03:45:27.903] Timer tick, asking Buildbucket for the build status
[03:45:28.089] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:28.089] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:117:0) after 1m0s
[03:46:28.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:117:0)
[03:46:28.303] Timer tick, asking Buildbucket for the build status
[03:46:28.466] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:28.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:118:0) after 1m0s
[03:47:28.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:118:0)
[03:47:28.770] Timer tick, asking Buildbucket for the build status
[03:47:28.835] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:28.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:119:0) after 1m0s
[03:48:28.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:119:0)
[03:48:28.943] Timer tick, asking Buildbucket for the build status
[03:48:28.999] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:28.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:120:0) after 1m0s
[03:49:29.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:120:0)
[03:49:29.198] Timer tick, asking Buildbucket for the build status
[03:49:29.330] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:29.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:121:0) after 1m0s
[03:50:29.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:121:0)
[03:50:29.547] Timer tick, asking Buildbucket for the build status
[03:50:29.646] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:29.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:122:0) after 1m0s
[03:51:29.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:122:0)
[03:51:29.800] Timer tick, asking Buildbucket for the build status
[03:51:30.128] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:30.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:123:0) after 1m0s
[03:52:30.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:123:0)
[03:52:30.319] Timer tick, asking Buildbucket for the build status
[03:52:30.559] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:30.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:124:0) after 1m0s
[03:53:30.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:124:0)
[03:53:30.661] Timer tick, asking Buildbucket for the build status
[03:53:30.750] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:30.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:125:0) after 1m0s
[03:54:30.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:125:0)
[03:54:30.846] Timer tick, asking Buildbucket for the build status
[03:54:30.921] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:30.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:126:0) after 1m0s
[03:55:30.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:126:0)
[03:55:30.948] Timer tick, asking Buildbucket for the build status
[03:55:31.379] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:31.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:127:0) after 1m0s
[03:56:31.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:127:0)
[03:56:31.434] Timer tick, asking Buildbucket for the build status
[03:56:31.559] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:31.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:128:0) after 1m0s
[03:57:31.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:128:0)
[03:57:31.585] Timer tick, asking Buildbucket for the build status
[03:57:31.658] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:31.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:129:0) after 1m0s
[03:58:31.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:129:0)
[03:58:31.729] Timer tick, asking Buildbucket for the build status
[03:58:31.964] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:31.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:130:0) after 1m0s
[03:59:32.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:130:0)
[03:59:32.070] Timer tick, asking Buildbucket for the build status
[03:59:32.199] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:32.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:131:0) after 1m0s
[04:00:32.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:131:0)
[04:00:32.314] Timer tick, asking Buildbucket for the build status
[04:00:32.389] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:32.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:132:0) after 1m0s
[04:01:32.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:132:0)
[04:01:32.427] Timer tick, asking Buildbucket for the build status
[04:01:32.542] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:32.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:133:0) after 1m0s
[04:02:32.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:133:0)
[04:02:32.540] Timer tick, asking Buildbucket for the build status
[04:02:32.595] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:32.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:134:0) after 1m0s
[04:03:32.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:134:0)
[04:03:32.661] Timer tick, asking Buildbucket for the build status
[04:03:32.745] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:32.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:135:0) after 1m0s
[04:04:32.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:135:0)
[04:04:32.737] Timer tick, asking Buildbucket for the build status
[04:04:32.798] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:32.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:136:0) after 1m0s
[04:05:32.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:136:0)
[04:05:32.908] Timer tick, asking Buildbucket for the build status
[04:05:33.008] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:33.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:137:0) after 1m0s
[04:06:33.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:137:0)
[04:06:33.078] Timer tick, asking Buildbucket for the build status
[04:06:33.225] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:33.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:138:0) after 1m0s
[04:07:33.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:138:0)
[04:07:33.339] Timer tick, asking Buildbucket for the build status
[04:07:33.522] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:33.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:139:0) after 1m0s
[04:08:33.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:139:0)
[04:08:33.723] Timer tick, asking Buildbucket for the build status
[04:08:33.781] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:33.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:140:0) after 1m0s
[04:09:33.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:140:0)
[04:09:33.845] Timer tick, asking Buildbucket for the build status
[04:09:33.904] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:33.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:141:0) after 1m0s
[04:10:33.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:141:0)
[04:10:33.981] Timer tick, asking Buildbucket for the build status
[04:10:34.058] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:34.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:142:0) after 1m0s
[04:11:34.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:142:0)
[04:11:34.155] Timer tick, asking Buildbucket for the build status
[04:11:34.410] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:34.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:143:0) after 1m0s
[04:12:34.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:143:0)
[04:12:34.477] Timer tick, asking Buildbucket for the build status
[04:12:34.546] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:34.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:144:0) after 1m0s
[04:13:34.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:144:0)
[04:13:34.571] Timer tick, asking Buildbucket for the build status
[04:13:34.645] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:34.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:145:0) after 1m0s
[04:14:34.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:145:0)
[04:14:34.671] Timer tick, asking Buildbucket for the build status
[04:14:34.730] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:34.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:146:0) after 1m0s
[04:15:34.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:146:0)
[04:15:34.731] Timer tick, asking Buildbucket for the build status
[04:15:34.791] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:34.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:147:0) after 1m0s
[04:16:34.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:147:0)
[04:16:34.820] Timer tick, asking Buildbucket for the build status
[04:16:34.976] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:34.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:148:0) after 1m0s
[04:17:35.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:148:0)
[04:17:35.087] Timer tick, asking Buildbucket for the build status
[04:17:35.149] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:35.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:149:0) after 1m0s
[04:18:35.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:149:0)
[04:18:35.279] Timer tick, asking Buildbucket for the build status
[04:18:35.343] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:35.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:150:0) after 1m0s
[04:19:35.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:150:0)
[04:19:35.375] Timer tick, asking Buildbucket for the build status
[04:19:35.644] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:35.644] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:151:0) after 1m0s
[04:20:35.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:151:0)
[04:20:35.830] Timer tick, asking Buildbucket for the build status
[04:20:35.910] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:35.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:152:0) after 1m0s
[04:21:36.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:152:0)
[04:21:36.125] Timer tick, asking Buildbucket for the build status
[04:21:36.238] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:36.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:153:0) after 1m0s
[04:22:36.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:153:0)
[04:22:36.436] Timer tick, asking Buildbucket for the build status
[04:22:36.489] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:36.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:154:0) after 1m0s
[04:23:36.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:154:0)
[04:23:36.647] Timer tick, asking Buildbucket for the build status
[04:23:36.812] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:36.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:155:0) after 1m0s
[04:24:36.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:155:0)
[04:24:36.971] Timer tick, asking Buildbucket for the build status
[04:24:37.037] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:37.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:156:0) after 1m0s
[04:25:37.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:156:0)
[04:25:37.336] Timer tick, asking Buildbucket for the build status
[04:25:37.396] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:37.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:157:0) after 1m0s
[04:26:37.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:157:0)
[04:26:37.683] Timer tick, asking Buildbucket for the build status
[04:26:38.245] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:38.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:158:0) after 1m0s
[04:27:38.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:158:0)
[04:27:38.339] Timer tick, asking Buildbucket for the build status
[04:27:38.605] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:38.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:159:0) after 1m0s
[04:28:38.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:159:0)
[04:28:38.754] Timer tick, asking Buildbucket for the build status
[04:28:38.839] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:38.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:160:0) after 1m0s
[04:29:38.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:160:0)
[04:29:38.999] Timer tick, asking Buildbucket for the build status
[04:29:39.087] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:39.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:161:0) after 1m0s
[04:30:39.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:161:0)
[04:30:39.256] Timer tick, asking Buildbucket for the build status
[04:30:39.326] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:39.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:162:0) after 1m0s
[04:31:39.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:162:0)
[04:31:39.452] Timer tick, asking Buildbucket for the build status
[04:31:39.801] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:39.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:163:0) after 1m0s
[04:32:39.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:163:0)
[04:32:39.829] Timer tick, asking Buildbucket for the build status
[04:32:39.889] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:39.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:164:0) after 1m0s
[04:33:39.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:164:0)
[04:33:39.943] Timer tick, asking Buildbucket for the build status
[04:33:40.196] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:40.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:165:0) after 1m0s
[04:34:40.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:165:0)
[04:34:40.256] Timer tick, asking Buildbucket for the build status
[04:34:40.332] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:40.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:166:0) after 1m0s
[04:35:40.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:166:0)
[04:35:40.407] Timer tick, asking Buildbucket for the build status
[04:35:40.648] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:40.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:167:0) after 1m0s
[04:36:40.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:167:0)
[04:36:40.682] Timer tick, asking Buildbucket for the build status
[04:36:40.797] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:40.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:168:0) after 1m0s
[04:37:40.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:168:0)
[04:37:40.864] Timer tick, asking Buildbucket for the build status
[04:37:40.945] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:40.945] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:169:0) after 1m0s
[04:38:40.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:169:0)
[04:38:40.976] Timer tick, asking Buildbucket for the build status
[04:38:41.056] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:41.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:170:0) after 1m0s
[04:39:41.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:170:0)
[04:39:41.277] Timer tick, asking Buildbucket for the build status
[04:39:41.530] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:41.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:171:0) after 1m0s
[04:40:41.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:171:0)
[04:40:41.704] Timer tick, asking Buildbucket for the build status
[04:40:41.936] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:41.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:172:0) after 1m0s
[04:41:42.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:172:0)
[04:41:42.142] Timer tick, asking Buildbucket for the build status
[04:41:42.302] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:42.303] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:173:0) after 1m0s
[04:42:42.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:173:0)
[04:42:42.369] Timer tick, asking Buildbucket for the build status
[04:42:42.432] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:42.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:174:0) after 1m0s
[04:43:42.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:174:0)
[04:43:42.470] Timer tick, asking Buildbucket for the build status
[04:43:42.652] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:42.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:175:0) after 1m0s
[04:44:42.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:175:0)
[04:44:42.764] Timer tick, asking Buildbucket for the build status
[04:44:43.390] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:43.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:176:0) after 1m0s
[04:45:43.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:176:0)
[04:45:43.405] Timer tick, asking Buildbucket for the build status
[04:45:43.823] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:43.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:177:0) after 1m0s
[04:46:43.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:177:0)
[04:46:43.880] Timer tick, asking Buildbucket for the build status
[04:46:44.027] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:44.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:178:0) after 1m0s
[04:47:44.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:178:0)
[04:47:44.059] Timer tick, asking Buildbucket for the build status
[04:47:44.125] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:44.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:179:0) after 1m0s
[04:48:44.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:179:0)
[04:48:44.147] Timer tick, asking Buildbucket for the build status
[04:48:44.207] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:44.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:180:0) after 1m0s
[04:49:44.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:180:0)
[04:49:44.302] Timer tick, asking Buildbucket for the build status
[04:49:44.391] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:44.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:181:0) after 1m0s
[04:50:44.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:181:0)
[04:50:44.543] Timer tick, asking Buildbucket for the build status
[04:50:44.824] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:44.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:182:0) after 1m0s
[04:51:44.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:182:0)
[04:51:44.941] Timer tick, asking Buildbucket for the build status
[04:51:45.064] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:45.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:183:0) after 1m0s
[04:52:45.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:183:0)
[04:52:45.117] Timer tick, asking Buildbucket for the build status
[04:52:45.182] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:45.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:184:0) after 1m0s
[04:53:45.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:184:0)
[04:53:45.240] Timer tick, asking Buildbucket for the build status
[04:53:45.319] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:45.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:185:0) after 1m0s
[04:54:45.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:185:0)
[04:54:45.376] Timer tick, asking Buildbucket for the build status
[04:54:45.454] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:45.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:186:0) after 1m0s
[04:55:45.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:186:0)
[04:55:45.620] Timer tick, asking Buildbucket for the build status
[04:55:45.799] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:45.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:187:0) after 1m0s
[04:56:45.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:187:0)
[04:56:45.850] Timer tick, asking Buildbucket for the build status
[04:56:45.965] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:45.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:188:0) after 1m0s
[04:57:46.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:188:0)
[04:57:46.159] Timer tick, asking Buildbucket for the build status
[04:57:46.341] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:46.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:189:0) after 1m0s
[04:58:46.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:189:0)
[04:58:46.351] Timer tick, asking Buildbucket for the build status
[04:58:46.436] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:46.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:190:0) after 1m0s
[04:59:46.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:190:0)
[04:59:46.472] Timer tick, asking Buildbucket for the build status
[04:59:46.551] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:46.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:191:0) after 1m0s
[05:00:46.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:191:0)
[05:00:46.727] Timer tick, asking Buildbucket for the build status
[05:00:46.856] Build 8861248978247817104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:46.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026679040285513296:192:0) after 1m0s
[05:01:13.949] Received PubSub notification, asking Buildbucket for the build status
[05:01:14.055] Build 8861248978247817104: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:01:14.055] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1607662872981815",
"created_by": "project:infra",
"created_ts": "1607651460371261",
"id": "8861248978247817104",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"89.0.4350.5\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"bc9f868e-d5dc-4c5b-a1a1-0a5fcf71d526\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"89.0.4350.5\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-b0a8\"], \"image\": [\"chrome-xenial-20120600-c5cfbe11ce8\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607651481344171",
"status": "COMPLETED",
"status_changed_ts": "1607662873606619",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9026679040285513296",
"scheduler_job_id:infra/Build From Tarball",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8861248978247817104/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:build_from_tarball",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_task_id:5068500f27068c10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1607662873621636",
"url": "https://ci.chromium.org/b/8861248978247817104",
"utcnow_ts": "1607662874039815"
}
}
[05:01:14.055] Invocation finished in 3h10m15.010146265s with status SUCCEEDED