[01:37:00.223] New invocation is queued and will start shortly
[01:37:00.223] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[01:37:02.491] Starting the invocation (attempt 1)
[01:37:02.551] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:37:02.551] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:37:02.551] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9029941410659396624",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"87.0.4280.47\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"ed2ebf60-be3b-4708-bf69-f5b3677d9116\",\"title\":\"publish_tarball/0\"}]},\"version\":\"87.0.4280.47\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9029941410659396624",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[01:37:03.977] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1604540222722267",
"id": "8864511347377037616",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4280.47\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ed2ebf60-be3b-4708-bf69-f5b3677d9116\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4280.47\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604540223498702",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9029941410659396624",
"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/8864511347377037616/+/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": "1604540223498865",
"url": "https://ci.chromium.org/b/8864511347377037616",
"utcnow_ts": "1604540223949505"
}
}
[01:37:03.977] Task URL: https://ci.chromium.org/b/8864511347377037616
[01:37:03.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:2:0) after 1m0s
[01:38:01.568] Received PubSub notification, asking Buildbucket for the build status
[01:38:01.909] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:04.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:2:0)
[01:38:04.067] Timer tick, asking Buildbucket for the build status
[01:38:04.465] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:04.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:4:0) after 1m0s
[01:39:04.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:4:0)
[01:39:04.540] Timer tick, asking Buildbucket for the build status
[01:39:04.691] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:04.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:5:0) after 1m0s
[01:40:04.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:5:0)
[01:40:04.773] Timer tick, asking Buildbucket for the build status
[01:40:05.132] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:05.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:6:0) after 1m0s
[01:41:05.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:6:0)
[01:41:05.196] Timer tick, asking Buildbucket for the build status
[01:41:05.503] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:05.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:7:0) after 1m0s
[01:42:05.524] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:7:0)
[01:42:05.524] Timer tick, asking Buildbucket for the build status
[01:42:05.649] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:05.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:8:0) after 1m0s
[01:43:05.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:8:0)
[01:43:05.668] Timer tick, asking Buildbucket for the build status
[01:43:05.728] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:05.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:9:0) after 1m0s
[01:44:05.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:9:0)
[01:44:05.785] Timer tick, asking Buildbucket for the build status
[01:44:05.854] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:05.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:10:0) after 1m0s
[01:45:06.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:10:0)
[01:45:06.105] Timer tick, asking Buildbucket for the build status
[01:45:06.568] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:06.568] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:11:0) after 1m0s
[01:46:06.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:11:0)
[01:46:06.746] Timer tick, asking Buildbucket for the build status
[01:46:06.861] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:06.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:12:0) after 1m0s
[01:47:06.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:12:0)
[01:47:06.930] Timer tick, asking Buildbucket for the build status
[01:47:07.332] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:07.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:13:0) after 1m0s
[01:48:07.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:13:0)
[01:48:07.365] Timer tick, asking Buildbucket for the build status
[01:48:07.441] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:07.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:14:0) after 1m0s
[01:49:07.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:14:0)
[01:49:07.536] Timer tick, asking Buildbucket for the build status
[01:49:08.030] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:08.030] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:15:0) after 1m0s
[01:50:08.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:15:0)
[01:50:08.096] Timer tick, asking Buildbucket for the build status
[01:50:08.150] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:08.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:16:0) after 1m0s
[01:51:08.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:16:0)
[01:51:08.197] Timer tick, asking Buildbucket for the build status
[01:51:08.645] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:08.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:17:0) after 1m0s
[01:52:08.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:17:0)
[01:52:08.797] Timer tick, asking Buildbucket for the build status
[01:52:09.001] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:09.001] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:18:0) after 1m0s
[01:53:09.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:18:0)
[01:53:09.233] Timer tick, asking Buildbucket for the build status
[01:53:09.429] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:09.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:19:0) after 1m0s
[01:54:09.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:19:0)
[01:54:09.635] Timer tick, asking Buildbucket for the build status
[01:54:09.851] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:09.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:20:0) after 1m0s
[01:55:09.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:20:0)
[01:55:09.988] Timer tick, asking Buildbucket for the build status
[01:55:10.642] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:10.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:21:0) after 1m0s
[01:56:10.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:21:0)
[01:56:10.774] Timer tick, asking Buildbucket for the build status
[01:56:10.841] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:10.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:22:0) after 1m0s
[01:57:11.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:22:0)
[01:57:11.021] Timer tick, asking Buildbucket for the build status
[01:57:11.146] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:11.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:23:0) after 1m0s
[01:58:11.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:23:0)
[01:58:11.227] Timer tick, asking Buildbucket for the build status
[01:58:11.283] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:11.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:24:0) after 1m0s
[01:59:11.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:24:0)
[01:59:11.340] Timer tick, asking Buildbucket for the build status
[01:59:11.428] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:11.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:25:0) after 1m0s
[02:00:11.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:25:0)
[02:00:11.528] Timer tick, asking Buildbucket for the build status
[02:00:11.637] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:11.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:26:0) after 1m0s
[02:01:12.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:26:0)
[02:01:12.885] Timer tick, asking Buildbucket for the build status
[02:01:14.471] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:14.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:27:0) after 1m0s
[02:02:14.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:27:0)
[02:02:14.615] Timer tick, asking Buildbucket for the build status
[02:02:14.763] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:14.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:28:0) after 1m0s
[02:03:14.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:28:0)
[02:03:14.849] Timer tick, asking Buildbucket for the build status
[02:03:14.968] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:14.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:29:0) after 1m0s
[02:04:15.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:29:0)
[02:04:15.031] Timer tick, asking Buildbucket for the build status
[02:04:15.479] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:15.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:30:0) after 1m0s
[02:05:15.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:30:0)
[02:05:15.474] Timer tick, asking Buildbucket for the build status
[02:05:15.551] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:15.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:31:0) after 1m0s
[02:06:15.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:31:0)
[02:06:15.579] Timer tick, asking Buildbucket for the build status
[02:06:15.811] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:15.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:32:0) after 1m0s
[02:07:15.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:32:0)
[02:07:15.835] Timer tick, asking Buildbucket for the build status
[02:07:15.950] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:15.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:33:0) after 1m0s
[02:08:16.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:33:0)
[02:08:16.007] Timer tick, asking Buildbucket for the build status
[02:08:16.420] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:16.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:34:0) after 1m0s
[02:09:16.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:34:0)
[02:09:16.442] Timer tick, asking Buildbucket for the build status
[02:09:16.597] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:16.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:35:0) after 1m0s
[02:10:16.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:35:0)
[02:10:16.729] Timer tick, asking Buildbucket for the build status
[02:10:17.272] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:17.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:36:0) after 1m0s
[02:11:17.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:36:0)
[02:11:17.320] Timer tick, asking Buildbucket for the build status
[02:11:17.470] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:17.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:37:0) after 1m0s
[02:12:17.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:37:0)
[02:12:17.596] Timer tick, asking Buildbucket for the build status
[02:12:17.702] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:17.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:38:0) after 1m0s
[02:13:17.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:38:0)
[02:13:17.724] Timer tick, asking Buildbucket for the build status
[02:13:17.810] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:17.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:39:0) after 1m0s
[02:14:17.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:39:0)
[02:14:17.836] Timer tick, asking Buildbucket for the build status
[02:14:18.163] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:18.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:40:0) after 1m0s
[02:15:18.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:40:0)
[02:15:18.182] Timer tick, asking Buildbucket for the build status
[02:15:18.255] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:18.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:41:0) after 1m0s
[02:16:18.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:41:0)
[02:16:18.290] Timer tick, asking Buildbucket for the build status
[02:16:18.370] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:18.370] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:42:0) after 1m0s
[02:17:18.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:42:0)
[02:17:18.409] Timer tick, asking Buildbucket for the build status
[02:17:18.525] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:18.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:43:0) after 1m0s
[02:18:18.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:43:0)
[02:18:18.585] Timer tick, asking Buildbucket for the build status
[02:18:18.847] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:18.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:44:0) after 1m0s
[02:19:18.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:44:0)
[02:19:18.858] Timer tick, asking Buildbucket for the build status
[02:19:18.936] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:18.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:45:0) after 1m0s
[02:20:18.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:45:0)
[02:20:18.959] Timer tick, asking Buildbucket for the build status
[02:20:19.314] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:19.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:46:0) after 1m0s
[02:21:19.332] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:46:0)
[02:21:19.332] Timer tick, asking Buildbucket for the build status
[02:21:19.450] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:19.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:47:0) after 1m0s
[02:22:19.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:47:0)
[02:22:19.429] Timer tick, asking Buildbucket for the build status
[02:22:19.540] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:19.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:48:0) after 1m0s
[02:23:19.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:48:0)
[02:23:19.554] Timer tick, asking Buildbucket for the build status
[02:23:19.630] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:19.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:49:0) after 1m0s
[02:24:19.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:49:0)
[02:24:19.622] Timer tick, asking Buildbucket for the build status
[02:24:19.691] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:19.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:50:0) after 1m0s
[02:25:19.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:50:0)
[02:25:19.745] Timer tick, asking Buildbucket for the build status
[02:25:19.828] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:19.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:51:0) after 1m0s
[02:26:19.888] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:51:0)
[02:26:19.888] Timer tick, asking Buildbucket for the build status
[02:26:19.955] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:19.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:52:0) after 1m0s
[02:27:20.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:52:0)
[02:27:20.076] Timer tick, asking Buildbucket for the build status
[02:27:20.431] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:20.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:53:0) after 1m0s
[02:28:20.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:53:0)
[02:28:20.413] Timer tick, asking Buildbucket for the build status
[02:28:20.530] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:20.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:54:0) after 1m0s
[02:29:20.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:54:0)
[02:29:20.610] Timer tick, asking Buildbucket for the build status
[02:29:20.843] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:20.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:55:0) after 1m0s
[02:30:20.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:55:0)
[02:30:20.876] Timer tick, asking Buildbucket for the build status
[02:30:20.948] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:20.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:56:0) after 1m0s
[02:31:20.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:56:0)
[02:31:20.970] Timer tick, asking Buildbucket for the build status
[02:31:21.109] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:21.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:57:0) after 1m0s
[02:32:21.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:57:0)
[02:32:21.137] Timer tick, asking Buildbucket for the build status
[02:32:21.409] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:21.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:58:0) after 1m0s
[02:33:21.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:58:0)
[02:33:21.432] Timer tick, asking Buildbucket for the build status
[02:33:21.495] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:21.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:59:0) after 1m0s
[02:34:21.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:59:0)
[02:34:21.588] Timer tick, asking Buildbucket for the build status
[02:34:21.638] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:21.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:60:0) after 1m0s
[02:35:21.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:60:0)
[02:35:21.650] Timer tick, asking Buildbucket for the build status
[02:35:21.718] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:21.718] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:61:0) after 1m0s
[02:36:21.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:61:0)
[02:36:21.746] Timer tick, asking Buildbucket for the build status
[02:36:21.840] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:21.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:62:0) after 1m0s
[02:37:21.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:62:0)
[02:37:21.895] Timer tick, asking Buildbucket for the build status
[02:37:22.013] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:22.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:63:0) after 1m0s
[02:38:22.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:63:0)
[02:38:22.065] Timer tick, asking Buildbucket for the build status
[02:38:22.156] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:22.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:64:0) after 1m0s
[02:39:22.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:64:0)
[02:39:22.231] Timer tick, asking Buildbucket for the build status
[02:39:22.310] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:22.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:65:0) after 1m0s
[02:40:22.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:65:0)
[02:40:22.559] Timer tick, asking Buildbucket for the build status
[02:40:22.712] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:22.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:66:0) after 1m0s
[02:41:22.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:66:0)
[02:41:22.736] Timer tick, asking Buildbucket for the build status
[02:41:22.793] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:22.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:67:0) after 1m0s
[02:42:25.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:67:0)
[02:42:25.699] Timer tick, asking Buildbucket for the build status
[02:42:25.835] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:25.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:68:0) after 1m0s
[02:43:25.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:68:0)
[02:43:25.956] Timer tick, asking Buildbucket for the build status
[02:43:26.024] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:26.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:69:0) after 1m0s
[02:44:26.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:69:0)
[02:44:26.031] Timer tick, asking Buildbucket for the build status
[02:44:26.115] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:26.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:70:0) after 1m0s
[02:45:26.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:70:0)
[02:45:26.162] Timer tick, asking Buildbucket for the build status
[02:45:26.229] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:26.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:71:0) after 1m0s
[02:46:26.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:71:0)
[02:46:26.273] Timer tick, asking Buildbucket for the build status
[02:46:26.352] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:26.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:72:0) after 1m0s
[02:47:26.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:72:0)
[02:47:26.391] Timer tick, asking Buildbucket for the build status
[02:47:26.510] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:26.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:73:0) after 1m0s
[02:48:26.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:73:0)
[02:48:26.632] Timer tick, asking Buildbucket for the build status
[02:48:26.696] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:26.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:74:0) after 1m0s
[02:49:26.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:74:0)
[02:49:26.768] Timer tick, asking Buildbucket for the build status
[02:49:26.998] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:26.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:75:0) after 1m0s
[02:50:27.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:75:0)
[02:50:27.035] Timer tick, asking Buildbucket for the build status
[02:50:27.132] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:27.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:76:0) after 1m0s
[02:51:27.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:76:0)
[02:51:27.177] Timer tick, asking Buildbucket for the build status
[02:51:27.511] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:27.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:77:0) after 1m0s
[02:52:27.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:77:0)
[02:52:27.548] Timer tick, asking Buildbucket for the build status
[02:52:27.663] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:27.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:78:0) after 1m0s
[02:53:27.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:78:0)
[02:53:27.699] Timer tick, asking Buildbucket for the build status
[02:53:27.757] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:27.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:79:0) after 1m0s
[02:54:27.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:79:0)
[02:54:27.806] Timer tick, asking Buildbucket for the build status
[02:54:28.104] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:28.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:80:0) after 1m0s
[02:55:28.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:80:0)
[02:55:28.199] Timer tick, asking Buildbucket for the build status
[02:55:28.468] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:28.468] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:81:0) after 1m0s
[02:56:28.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:81:0)
[02:56:28.507] Timer tick, asking Buildbucket for the build status
[02:56:28.888] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:28.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:82:0) after 1m0s
[02:57:28.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:82:0)
[02:57:28.910] Timer tick, asking Buildbucket for the build status
[02:57:29.018] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:29.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:83:0) after 1m0s
[02:58:29.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:83:0)
[02:58:29.082] Timer tick, asking Buildbucket for the build status
[02:58:29.152] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:29.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:84:0) after 1m0s
[02:59:29.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:84:0)
[02:59:29.183] Timer tick, asking Buildbucket for the build status
[02:59:29.244] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:29.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:85:0) after 1m0s
[03:00:29.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:85:0)
[03:00:29.353] Timer tick, asking Buildbucket for the build status
[03:00:29.419] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:29.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:86:0) after 1m0s
[03:01:29.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:86:0)
[03:01:29.483] Timer tick, asking Buildbucket for the build status
[03:01:29.559] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:29.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:87:0) after 1m0s
[03:02:29.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:87:0)
[03:02:29.550] Timer tick, asking Buildbucket for the build status
[03:02:29.656] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:29.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:88:0) after 1m0s
[03:03:29.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:88:0)
[03:03:29.702] Timer tick, asking Buildbucket for the build status
[03:03:29.780] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:29.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:89:0) after 1m0s
[03:04:29.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:89:0)
[03:04:29.807] Timer tick, asking Buildbucket for the build status
[03:04:29.872] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:29.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:90:0) after 1m0s
[03:05:29.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:90:0)
[03:05:29.895] Timer tick, asking Buildbucket for the build status
[03:05:30.060] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:30.060] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:91:0) after 1m0s
[03:06:30.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:91:0)
[03:06:30.122] Timer tick, asking Buildbucket for the build status
[03:06:30.208] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:30.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:92:0) after 1m0s
[03:07:30.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:92:0)
[03:07:30.241] Timer tick, asking Buildbucket for the build status
[03:07:30.359] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:30.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:93:0) after 1m0s
[03:08:30.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:93:0)
[03:08:30.343] Timer tick, asking Buildbucket for the build status
[03:08:30.396] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:30.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:94:0) after 1m0s
[03:09:30.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:94:0)
[03:09:30.426] Timer tick, asking Buildbucket for the build status
[03:09:30.707] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:30.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:95:0) after 1m0s
[03:10:30.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:95:0)
[03:10:30.786] Timer tick, asking Buildbucket for the build status
[03:10:30.872] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:30.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:96:0) after 1m0s
[03:11:30.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:96:0)
[03:11:30.916] Timer tick, asking Buildbucket for the build status
[03:11:30.999] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:30.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:97:0) after 1m0s
[03:12:31.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:97:0)
[03:12:31.119] Timer tick, asking Buildbucket for the build status
[03:12:31.243] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:31.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:98:0) after 1m0s
[03:13:31.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:98:0)
[03:13:31.264] Timer tick, asking Buildbucket for the build status
[03:13:31.390] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:31.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:99:0) after 1m0s
[03:14:31.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:99:0)
[03:14:31.385] Timer tick, asking Buildbucket for the build status
[03:14:31.455] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:31.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:100:0) after 1m0s
[03:15:31.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:100:0)
[03:15:31.541] Timer tick, asking Buildbucket for the build status
[03:15:31.615] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:31.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:101:0) after 1m0s
[03:16:31.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:101:0)
[03:16:31.679] Timer tick, asking Buildbucket for the build status
[03:16:31.737] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:31.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:102:0) after 1m0s
[03:17:31.772] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:102:0)
[03:17:31.772] Timer tick, asking Buildbucket for the build status
[03:17:32.485] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:32.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:103:0) after 1m0s
[03:18:32.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:103:0)
[03:18:32.562] Timer tick, asking Buildbucket for the build status
[03:18:32.771] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:32.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:104:0) after 1m0s
[03:19:32.826] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:104:0)
[03:19:32.826] Timer tick, asking Buildbucket for the build status
[03:19:32.894] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:32.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:105:0) after 1m0s
[03:20:32.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:105:0)
[03:20:32.911] Timer tick, asking Buildbucket for the build status
[03:20:33.210] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:33.210] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:106:0) after 1m0s
[03:21:33.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:106:0)
[03:21:33.259] Timer tick, asking Buildbucket for the build status
[03:21:33.324] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:33.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:107:0) after 1m0s
[03:22:33.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:107:0)
[03:22:33.382] Timer tick, asking Buildbucket for the build status
[03:22:33.518] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:33.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:108:0) after 1m0s
[03:23:33.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:108:0)
[03:23:33.570] Timer tick, asking Buildbucket for the build status
[03:23:33.641] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:33.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:109:0) after 1m0s
[03:24:33.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:109:0)
[03:24:33.671] Timer tick, asking Buildbucket for the build status
[03:24:33.734] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:33.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:110:0) after 1m0s
[03:25:33.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:110:0)
[03:25:33.791] Timer tick, asking Buildbucket for the build status
[03:25:33.868] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:33.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:111:0) after 1m0s
[03:26:33.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:111:0)
[03:26:33.934] Timer tick, asking Buildbucket for the build status
[03:26:34.087] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:34.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:112:0) after 1m0s
[03:27:34.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:112:0)
[03:27:34.202] Timer tick, asking Buildbucket for the build status
[03:27:34.409] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:34.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:113:0) after 1m0s
[03:28:34.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:113:0)
[03:28:34.432] Timer tick, asking Buildbucket for the build status
[03:28:34.531] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:34.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:114:0) after 1m0s
[03:29:34.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:114:0)
[03:29:34.557] Timer tick, asking Buildbucket for the build status
[03:29:34.639] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:34.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:115:0) after 1m0s
[03:30:34.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:115:0)
[03:30:34.669] Timer tick, asking Buildbucket for the build status
[03:30:34.837] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:34.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:116:0) after 1m0s
[03:31:34.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:116:0)
[03:31:34.922] Timer tick, asking Buildbucket for the build status
[03:31:34.986] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:34.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:117:0) after 1m0s
[03:32:35.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:117:0)
[03:32:35.018] Timer tick, asking Buildbucket for the build status
[03:32:35.119] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:35.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:118:0) after 1m0s
[03:33:35.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:118:0)
[03:33:35.144] Timer tick, asking Buildbucket for the build status
[03:33:35.216] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:35.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:119:0) after 1m0s
[03:34:35.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:119:0)
[03:34:35.308] Timer tick, asking Buildbucket for the build status
[03:34:35.435] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:35.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:120:0) after 1m0s
[03:35:35.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:120:0)
[03:35:35.502] Timer tick, asking Buildbucket for the build status
[03:35:35.581] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:35.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:121:0) after 1m0s
[03:36:35.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:121:0)
[03:36:35.606] Timer tick, asking Buildbucket for the build status
[03:36:35.727] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:35.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:122:0) after 1m0s
[03:37:35.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:122:0)
[03:37:35.753] Timer tick, asking Buildbucket for the build status
[03:37:36.108] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:36.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:123:0) after 1m0s
[03:38:36.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:123:0)
[03:38:36.167] Timer tick, asking Buildbucket for the build status
[03:38:36.331] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:36.331] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:124:0) after 1m0s
[03:39:36.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:124:0)
[03:39:36.417] Timer tick, asking Buildbucket for the build status
[03:39:37.328] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:37.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:125:0) after 1m0s
[03:40:37.360] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:125:0)
[03:40:37.360] Timer tick, asking Buildbucket for the build status
[03:40:37.431] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:37.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:126:0) after 1m0s
[03:41:37.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:126:0)
[03:41:37.454] Timer tick, asking Buildbucket for the build status
[03:41:37.507] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:37.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:127:0) after 1m0s
[03:42:37.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:127:0)
[03:42:37.562] Timer tick, asking Buildbucket for the build status
[03:42:37.939] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:37.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:128:0) after 1m0s
[03:43:38.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:128:0)
[03:43:38.034] Timer tick, asking Buildbucket for the build status
[03:43:38.276] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:38.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:129:0) after 1m0s
[03:44:38.332] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:129:0)
[03:44:38.332] Timer tick, asking Buildbucket for the build status
[03:44:38.481] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:38.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:130:0) after 1m0s
[03:45:38.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:130:0)
[03:45:38.493] Timer tick, asking Buildbucket for the build status
[03:45:39.132] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:39.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:131:0) after 1m0s
[03:46:39.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:131:0)
[03:46:39.157] Timer tick, asking Buildbucket for the build status
[03:46:39.216] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:39.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:132:0) after 1m0s
[03:47:39.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:132:0)
[03:47:39.238] Timer tick, asking Buildbucket for the build status
[03:47:39.514] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:39.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:133:0) after 1m0s
[03:48:39.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:133:0)
[03:48:39.560] Timer tick, asking Buildbucket for the build status
[03:48:39.728] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:39.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:134:0) after 1m0s
[03:49:39.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:134:0)
[03:49:39.755] Timer tick, asking Buildbucket for the build status
[03:49:39.835] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:39.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:135:0) after 1m0s
[03:50:40.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:135:0)
[03:50:40.009] Timer tick, asking Buildbucket for the build status
[03:50:40.584] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:40.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:136:0) after 1m0s
[03:51:40.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:136:0)
[03:51:40.801] Timer tick, asking Buildbucket for the build status
[03:51:40.889] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:40.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:137:0) after 1m0s
[03:52:41.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:137:0)
[03:52:41.034] Timer tick, asking Buildbucket for the build status
[03:52:41.163] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:41.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:138:0) after 1m0s
[03:53:41.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:138:0)
[03:53:41.186] Timer tick, asking Buildbucket for the build status
[03:53:41.245] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:41.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:139:0) after 1m0s
[03:54:41.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:139:0)
[03:54:41.296] Timer tick, asking Buildbucket for the build status
[03:54:41.369] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:41.370] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:140:0) after 1m0s
[03:55:41.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:140:0)
[03:55:41.395] Timer tick, asking Buildbucket for the build status
[03:55:41.447] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:41.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:141:0) after 1m0s
[03:56:41.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:141:0)
[03:56:41.487] Timer tick, asking Buildbucket for the build status
[03:56:41.591] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:41.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:142:0) after 1m0s
[03:57:41.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:142:0)
[03:57:41.673] Timer tick, asking Buildbucket for the build status
[03:57:41.765] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:41.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:143:0) after 1m0s
[03:58:41.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:143:0)
[03:58:41.769] Timer tick, asking Buildbucket for the build status
[03:58:41.980] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:41.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:144:0) after 1m0s
[03:59:41.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:144:0)
[03:59:41.984] Timer tick, asking Buildbucket for the build status
[03:59:42.189] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:42.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:145:0) after 1m0s
[04:00:42.280] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:145:0)
[04:00:42.280] Timer tick, asking Buildbucket for the build status
[04:00:44.115] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:44.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:146:0) after 1m0s
[04:01:44.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:146:0)
[04:01:44.156] Timer tick, asking Buildbucket for the build status
[04:01:44.496] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:44.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:147:0) after 1m0s
[04:02:44.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:147:0)
[04:02:44.545] Timer tick, asking Buildbucket for the build status
[04:02:44.899] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:44.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:148:0) after 1m0s
[04:03:44.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:148:0)
[04:03:44.923] Timer tick, asking Buildbucket for the build status
[04:03:44.996] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:44.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:149:0) after 1m0s
[04:04:45.019] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:149:0)
[04:04:45.019] Timer tick, asking Buildbucket for the build status
[04:04:45.123] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:45.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:150:0) after 1m0s
[04:05:45.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:150:0)
[04:05:45.199] Timer tick, asking Buildbucket for the build status
[04:05:45.587] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:45.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:151:0) after 1m0s
[04:06:45.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:151:0)
[04:06:45.622] Timer tick, asking Buildbucket for the build status
[04:06:45.722] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:45.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:152:0) after 1m0s
[04:07:45.772] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:152:0)
[04:07:45.772] Timer tick, asking Buildbucket for the build status
[04:07:45.891] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:45.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:153:0) after 1m0s
[04:08:45.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:153:0)
[04:08:45.956] Timer tick, asking Buildbucket for the build status
[04:08:46.037] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:46.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:154:0) after 1m0s
[04:09:46.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:154:0)
[04:09:46.069] Timer tick, asking Buildbucket for the build status
[04:09:46.247] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:46.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:155:0) after 1m0s
[04:10:46.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:155:0)
[04:10:46.303] Timer tick, asking Buildbucket for the build status
[04:10:46.365] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:46.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:156:0) after 1m0s
[04:11:46.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:156:0)
[04:11:46.474] Timer tick, asking Buildbucket for the build status
[04:11:46.555] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:46.555] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:157:0) after 1m0s
[04:12:46.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:157:0)
[04:12:46.581] Timer tick, asking Buildbucket for the build status
[04:12:46.724] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:46.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:158:0) after 1m0s
[04:13:46.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:158:0)
[04:13:46.755] Timer tick, asking Buildbucket for the build status
[04:13:46.833] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:46.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:159:0) after 1m0s
[04:14:46.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:159:0)
[04:14:46.859] Timer tick, asking Buildbucket for the build status
[04:14:46.926] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:46.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:160:0) after 1m0s
[04:15:46.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:160:0)
[04:15:46.964] Timer tick, asking Buildbucket for the build status
[04:15:47.082] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:47.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:161:0) after 1m0s
[04:16:47.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:161:0)
[04:16:47.215] Timer tick, asking Buildbucket for the build status
[04:16:47.447] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:47.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:162:0) after 1m0s
[04:17:47.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:162:0)
[04:17:47.461] Timer tick, asking Buildbucket for the build status
[04:17:47.580] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:47.580] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:163:0) after 1m0s
[04:18:47.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:163:0)
[04:18:47.619] Timer tick, asking Buildbucket for the build status
[04:18:47.688] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:47.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:164:0) after 1m0s
[04:19:47.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:164:0)
[04:19:47.777] Timer tick, asking Buildbucket for the build status
[04:19:47.895] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:47.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:165:0) after 1m0s
[04:20:48.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:165:0)
[04:20:48.096] Timer tick, asking Buildbucket for the build status
[04:20:48.159] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:48.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:166:0) after 1m0s
[04:21:48.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:166:0)
[04:21:48.308] Timer tick, asking Buildbucket for the build status
[04:21:48.389] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:48.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:167:0) after 1m0s
[04:22:48.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:167:0)
[04:22:48.430] Timer tick, asking Buildbucket for the build status
[04:22:48.601] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:48.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:168:0) after 1m0s
[04:23:48.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:168:0)
[04:23:48.686] Timer tick, asking Buildbucket for the build status
[04:23:48.834] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:48.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:169:0) after 1m0s
[04:24:48.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:169:0)
[04:24:48.886] Timer tick, asking Buildbucket for the build status
[04:24:48.950] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:48.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:170:0) after 1m0s
[04:25:49.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:170:0)
[04:25:49.028] Timer tick, asking Buildbucket for the build status
[04:25:49.532] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:49.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:171:0) after 1m0s
[04:26:49.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:171:0)
[04:26:49.604] Timer tick, asking Buildbucket for the build status
[04:26:49.711] Build 8864511347377037616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:49.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029941410659396624:172:0) after 1m0s
[04:27:28.154] Received PubSub notification, asking Buildbucket for the build status
[04:27:28.251] Build 8864511347377037616: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:27:28.251] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1604550447301462",
"created_by": "project:infra",
"created_ts": "1604540222722267",
"id": "8864511347377037616",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4280.47\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ed2ebf60-be3b-4708-bf69-f5b3677d9116\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4280.47\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-dz7f\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604540280887398",
"status": "COMPLETED",
"status_changed_ts": "1604550447897076",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9029941410659396624",
"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/8864511347377037616/+/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:4faede5bc61c3410",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1604550447911274",
"url": "https://ci.chromium.org/b/8864511347377037616",
"utcnow_ts": "1604550448236940"
}
}
[04:27:28.251] Invocation finished in 2h50m28.042940824s with status SUCCEEDED