[01:29:16.296] New invocation is queued and will start shortly
[01:29:16.296] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[01:29:17.401] Starting the invocation (attempt 1)
[01:29:17.447] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:29:17.447] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:29:17.447] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9085206046629873456",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"74.0.3725.3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9085206046629873456",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[01:29:18.465] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551835757516106",
"id": "8919775984685463840",
"lease_expiration_ts": "1551954558193411",
"lease_key": "2010465594",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"74.0.3725.3\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1551835758194341",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9085206046629873456",
"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/8919775984685463840/+/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:43697004d2532610",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1551835758194450",
"url": "https://ci.chromium.org/b/8919775984685463840",
"utcnow_ts": "1551835758451988"
}
}
[01:29:18.465] Task URL: https://ci.chromium.org/b/8919775984685463840
[01:29:18.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:2:0) after 1m0s
[01:29:48.259] Received PubSub notification, asking Buildbucket for the build status
[01:29:48.309] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:18.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:2:0)
[01:30:18.480] Timer tick, asking Buildbucket for the build status
[01:30:18.535] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:18.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:4:0) after 1m0s
[01:31:18.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:4:0)
[01:31:18.563] Timer tick, asking Buildbucket for the build status
[01:31:18.613] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:18.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:5:0) after 1m0s
[01:32:18.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:5:0)
[01:32:18.587] Timer tick, asking Buildbucket for the build status
[01:32:18.691] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:18.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:6:0) after 1m0s
[01:33:18.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:6:0)
[01:33:18.724] Timer tick, asking Buildbucket for the build status
[01:33:18.802] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:18.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:7:0) after 1m0s
[01:34:18.826] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:7:0)
[01:34:18.826] Timer tick, asking Buildbucket for the build status
[01:34:19.171] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:19.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:8:0) after 1m0s
[01:35:19.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:8:0)
[01:35:19.192] Timer tick, asking Buildbucket for the build status
[01:35:19.399] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:19.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:9:0) after 1m0s
[01:36:19.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:9:0)
[01:36:19.409] Timer tick, asking Buildbucket for the build status
[01:36:19.453] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:19.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:10:0) after 1m0s
[01:37:19.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:10:0)
[01:37:19.468] Timer tick, asking Buildbucket for the build status
[01:37:19.506] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:19.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:11:0) after 1m0s
[01:38:19.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:11:0)
[01:38:19.478] Timer tick, asking Buildbucket for the build status
[01:38:19.532] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:19.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:12:0) after 1m0s
[01:39:19.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:12:0)
[01:39:19.553] Timer tick, asking Buildbucket for the build status
[01:39:19.654] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:19.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:13:0) after 1m0s
[01:40:19.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:13:0)
[01:40:19.675] Timer tick, asking Buildbucket for the build status
[01:40:19.710] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:19.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:14:0) after 1m0s
[01:41:19.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:14:0)
[01:41:19.732] Timer tick, asking Buildbucket for the build status
[01:41:19.786] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:19.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:15:0) after 1m0s
[01:42:19.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:15:0)
[01:42:19.805] Timer tick, asking Buildbucket for the build status
[01:42:19.879] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:19.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:16:0) after 1m0s
[01:43:19.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:16:0)
[01:43:19.896] Timer tick, asking Buildbucket for the build status
[01:43:19.968] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:19.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:17:0) after 1m0s
[01:44:19.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:17:0)
[01:44:19.989] Timer tick, asking Buildbucket for the build status
[01:44:20.035] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:20.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:18:0) after 1m0s
[01:45:20.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:18:0)
[01:45:20.060] Timer tick, asking Buildbucket for the build status
[01:45:20.097] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:20.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:19:0) after 1m0s
[01:46:20.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:19:0)
[01:46:20.096] Timer tick, asking Buildbucket for the build status
[01:46:20.134] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:20.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:20:0) after 1m0s
[01:47:20.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:20:0)
[01:47:20.154] Timer tick, asking Buildbucket for the build status
[01:47:20.347] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:20.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:21:0) after 1m0s
[01:48:20.332] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:21:0)
[01:48:20.332] Timer tick, asking Buildbucket for the build status
[01:48:20.369] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:20.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:22:0) after 1m0s
[01:49:20.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:22:0)
[01:49:20.387] Timer tick, asking Buildbucket for the build status
[01:49:20.458] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:20.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:23:0) after 1m0s
[01:50:20.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:23:0)
[01:50:20.490] Timer tick, asking Buildbucket for the build status
[01:50:20.603] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:20.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:24:0) after 1m0s
[01:51:20.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:24:0)
[01:51:20.647] Timer tick, asking Buildbucket for the build status
[01:51:20.686] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:20.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:25:0) after 1m0s
[01:52:20.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:25:0)
[01:52:20.702] Timer tick, asking Buildbucket for the build status
[01:52:20.742] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:20.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:26:0) after 1m0s
[01:53:20.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:26:0)
[01:53:20.760] Timer tick, asking Buildbucket for the build status
[01:53:20.801] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:20.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:27:0) after 1m0s
[01:54:20.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:27:0)
[01:54:20.784] Timer tick, asking Buildbucket for the build status
[01:54:21.048] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:21.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:28:0) after 1m0s
[01:55:21.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:28:0)
[01:55:21.066] Timer tick, asking Buildbucket for the build status
[01:55:21.176] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:21.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:29:0) after 1m0s
[01:56:21.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:29:0)
[01:56:21.198] Timer tick, asking Buildbucket for the build status
[01:56:21.233] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:21.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:30:0) after 1m0s
[01:57:21.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:30:0)
[01:57:21.255] Timer tick, asking Buildbucket for the build status
[01:57:21.299] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:21.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:31:0) after 1m0s
[01:58:21.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:31:0)
[01:58:21.313] Timer tick, asking Buildbucket for the build status
[01:58:21.381] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:21.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:32:0) after 1m0s
[01:59:21.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:32:0)
[01:59:21.408] Timer tick, asking Buildbucket for the build status
[01:59:21.607] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:21.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:33:0) after 1m0s
[02:00:21.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:33:0)
[02:00:21.649] Timer tick, asking Buildbucket for the build status
[02:00:21.682] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:21.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:34:0) after 1m0s
[02:01:21.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:34:0)
[02:01:21.656] Timer tick, asking Buildbucket for the build status
[02:01:21.693] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:21.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:35:0) after 1m0s
[02:02:21.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:35:0)
[02:02:21.708] Timer tick, asking Buildbucket for the build status
[02:02:21.798] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:21.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:36:0) after 1m0s
[02:03:21.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:36:0)
[02:03:21.802] Timer tick, asking Buildbucket for the build status
[02:03:21.844] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:21.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:37:0) after 1m0s
[02:04:21.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:37:0)
[02:04:21.867] Timer tick, asking Buildbucket for the build status
[02:04:22.261] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:22.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:38:0) after 1m0s
[02:05:22.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:38:0)
[02:05:22.261] Timer tick, asking Buildbucket for the build status
[02:05:22.299] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:22.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:39:0) after 1m0s
[02:06:22.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:39:0)
[02:06:22.335] Timer tick, asking Buildbucket for the build status
[02:06:22.414] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:22.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:40:0) after 1m0s
[02:07:22.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:40:0)
[02:07:22.413] Timer tick, asking Buildbucket for the build status
[02:07:22.453] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:22.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:41:0) after 1m0s
[02:08:22.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:41:0)
[02:08:22.469] Timer tick, asking Buildbucket for the build status
[02:08:22.500] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:22.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:42:0) after 1m0s
[02:09:22.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:42:0)
[02:09:22.519] Timer tick, asking Buildbucket for the build status
[02:09:22.551] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:22.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:43:0) after 1m0s
[02:10:22.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:43:0)
[02:10:22.568] Timer tick, asking Buildbucket for the build status
[02:10:22.623] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:22.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:44:0) after 1m0s
[02:11:22.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:44:0)
[02:11:22.632] Timer tick, asking Buildbucket for the build status
[02:11:22.910] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:22.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:45:0) after 1m0s
[02:12:22.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:45:0)
[02:12:22.912] Timer tick, asking Buildbucket for the build status
[02:12:22.951] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:22.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:46:0) after 1m0s
[02:13:23.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:46:0)
[02:13:23.045] Timer tick, asking Buildbucket for the build status
[02:13:23.207] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:23.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:47:0) after 1m0s
[02:14:23.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:47:0)
[02:14:23.198] Timer tick, asking Buildbucket for the build status
[02:14:23.256] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:23.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:48:0) after 1m0s
[02:15:23.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:48:0)
[02:15:23.317] Timer tick, asking Buildbucket for the build status
[02:15:23.394] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:23.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:49:0) after 1m0s
[02:16:23.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:49:0)
[02:16:23.414] Timer tick, asking Buildbucket for the build status
[02:16:23.465] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:23.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:50:0) after 1m0s
[02:17:23.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:50:0)
[02:17:23.479] Timer tick, asking Buildbucket for the build status
[02:17:23.526] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:23.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:51:0) after 1m0s
[02:18:23.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:51:0)
[02:18:23.495] Timer tick, asking Buildbucket for the build status
[02:18:23.549] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:23.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:52:0) after 1m0s
[02:19:23.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:52:0)
[02:19:23.650] Timer tick, asking Buildbucket for the build status
[02:19:23.710] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:23.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:53:0) after 1m0s
[02:20:23.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:53:0)
[02:20:23.735] Timer tick, asking Buildbucket for the build status
[02:20:23.801] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:23.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:54:0) after 1m0s
[02:21:23.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:54:0)
[02:21:23.793] Timer tick, asking Buildbucket for the build status
[02:21:23.830] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:23.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:55:0) after 1m0s
[02:22:23.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:55:0)
[02:22:23.843] Timer tick, asking Buildbucket for the build status
[02:22:23.882] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:23.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:56:0) after 1m0s
[02:23:23.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:56:0)
[02:23:23.902] Timer tick, asking Buildbucket for the build status
[02:23:23.938] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:23.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:57:0) after 1m0s
[02:24:23.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:57:0)
[02:24:23.961] Timer tick, asking Buildbucket for the build status
[02:24:24.003] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:24.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:58:0) after 1m0s
[02:25:24.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:58:0)
[02:25:24.068] Timer tick, asking Buildbucket for the build status
[02:25:24.116] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:24.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:59:0) after 1m0s
[02:26:24.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:59:0)
[02:26:24.091] Timer tick, asking Buildbucket for the build status
[02:26:24.125] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:24.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:60:0) after 1m0s
[02:27:24.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:60:0)
[02:27:24.159] Timer tick, asking Buildbucket for the build status
[02:27:24.194] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:24.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:61:0) after 1m0s
[02:28:24.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:61:0)
[02:28:24.185] Timer tick, asking Buildbucket for the build status
[02:28:24.276] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:24.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:62:0) after 1m0s
[02:29:24.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:62:0)
[02:29:24.256] Timer tick, asking Buildbucket for the build status
[02:29:24.306] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:24.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:63:0) after 1m0s
[02:30:24.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:63:0)
[02:30:24.301] Timer tick, asking Buildbucket for the build status
[02:30:24.356] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:24.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:64:0) after 1m0s
[02:31:24.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:64:0)
[02:31:24.386] Timer tick, asking Buildbucket for the build status
[02:31:24.434] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:24.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:65:0) after 1m0s
[02:32:24.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:65:0)
[02:32:24.454] Timer tick, asking Buildbucket for the build status
[02:32:24.559] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:24.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:66:0) after 1m0s
[02:33:24.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:66:0)
[02:33:24.579] Timer tick, asking Buildbucket for the build status
[02:33:24.613] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:24.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:67:0) after 1m0s
[02:34:24.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:67:0)
[02:34:24.724] Timer tick, asking Buildbucket for the build status
[02:34:24.775] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:24.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:68:0) after 1m0s
[02:35:24.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:68:0)
[02:35:24.745] Timer tick, asking Buildbucket for the build status
[02:35:24.778] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:24.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:69:0) after 1m0s
[02:36:24.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:69:0)
[02:36:24.820] Timer tick, asking Buildbucket for the build status
[02:36:24.879] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:24.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:70:0) after 1m0s
[02:37:24.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:70:0)
[02:37:24.899] Timer tick, asking Buildbucket for the build status
[02:37:24.957] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:24.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:71:0) after 1m0s
[02:38:24.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:71:0)
[02:38:24.977] Timer tick, asking Buildbucket for the build status
[02:38:25.013] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:25.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:72:0) after 1m0s
[02:39:25.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:72:0)
[02:39:25.046] Timer tick, asking Buildbucket for the build status
[02:39:25.101] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:25.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:73:0) after 1m0s
[02:40:25.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:73:0)
[02:40:25.098] Timer tick, asking Buildbucket for the build status
[02:40:25.137] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:25.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:74:0) after 1m0s
[02:41:25.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:74:0)
[02:41:25.177] Timer tick, asking Buildbucket for the build status
[02:41:25.230] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:25.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:75:0) after 1m0s
[02:42:25.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:75:0)
[02:42:25.203] Timer tick, asking Buildbucket for the build status
[02:42:25.236] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:25.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:76:0) after 1m0s
[02:43:25.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:76:0)
[02:43:25.272] Timer tick, asking Buildbucket for the build status
[02:43:25.313] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:25.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:77:0) after 1m0s
[02:44:25.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:77:0)
[02:44:25.290] Timer tick, asking Buildbucket for the build status
[02:44:25.380] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:25.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:78:0) after 1m0s
[02:45:25.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:78:0)
[02:45:25.402] Timer tick, asking Buildbucket for the build status
[02:45:25.558] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:25.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:79:0) after 1m0s
[02:46:25.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:79:0)
[02:46:25.578] Timer tick, asking Buildbucket for the build status
[02:46:25.644] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:25.644] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:80:0) after 1m0s
[02:47:25.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:80:0)
[02:47:25.661] Timer tick, asking Buildbucket for the build status
[02:47:25.699] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:25.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:81:0) after 1m0s
[02:48:25.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:81:0)
[02:48:25.719] Timer tick, asking Buildbucket for the build status
[02:48:25.800] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:25.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:82:0) after 1m0s
[02:49:25.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:82:0)
[02:49:25.820] Timer tick, asking Buildbucket for the build status
[02:49:25.865] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:25.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:83:0) after 1m0s
[02:50:25.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:83:0)
[02:50:25.884] Timer tick, asking Buildbucket for the build status
[02:50:25.926] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:25.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:84:0) after 1m0s
[02:51:25.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:84:0)
[02:51:25.949] Timer tick, asking Buildbucket for the build status
[02:51:26.081] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:26.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:85:0) after 1m0s
[02:52:26.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:85:0)
[02:52:26.115] Timer tick, asking Buildbucket for the build status
[02:52:26.157] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:26.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:86:0) after 1m0s
[02:53:26.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:86:0)
[02:53:26.148] Timer tick, asking Buildbucket for the build status
[02:53:26.207] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:26.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:87:0) after 1m0s
[02:54:26.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:87:0)
[02:54:26.186] Timer tick, asking Buildbucket for the build status
[02:54:26.224] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:26.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:88:0) after 1m0s
[02:55:26.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:88:0)
[02:55:26.244] Timer tick, asking Buildbucket for the build status
[02:55:26.348] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:26.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:89:0) after 1m0s
[02:56:26.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:89:0)
[02:56:26.354] Timer tick, asking Buildbucket for the build status
[02:56:26.405] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:26.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:90:0) after 1m0s
[02:57:26.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:90:0)
[02:57:26.432] Timer tick, asking Buildbucket for the build status
[02:57:26.467] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:26.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:91:0) after 1m0s
[02:58:26.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:91:0)
[02:58:26.476] Timer tick, asking Buildbucket for the build status
[02:58:26.683] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:26.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:92:0) after 1m0s
[02:59:26.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:92:0)
[02:59:26.704] Timer tick, asking Buildbucket for the build status
[02:59:26.852] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:26.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:93:0) after 1m0s
[03:00:26.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:93:0)
[03:00:26.885] Timer tick, asking Buildbucket for the build status
[03:00:26.974] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:26.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:94:0) after 1m0s
[03:01:27.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:94:0)
[03:01:27.001] Timer tick, asking Buildbucket for the build status
[03:01:27.042] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:27.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:95:0) after 1m0s
[03:02:27.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:95:0)
[03:02:27.074] Timer tick, asking Buildbucket for the build status
[03:02:27.123] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:27.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:96:0) after 1m0s
[03:03:27.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:96:0)
[03:03:27.142] Timer tick, asking Buildbucket for the build status
[03:03:27.208] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:27.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:97:0) after 1m0s
[03:04:27.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:97:0)
[03:04:27.246] Timer tick, asking Buildbucket for the build status
[03:04:27.393] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:27.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:98:0) after 1m0s
[03:05:27.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:98:0)
[03:05:27.417] Timer tick, asking Buildbucket for the build status
[03:05:27.459] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:27.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:99:0) after 1m0s
[03:06:27.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:99:0)
[03:06:27.446] Timer tick, asking Buildbucket for the build status
[03:06:27.558] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:27.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:100:0) after 1m0s
[03:07:27.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:100:0)
[03:07:27.589] Timer tick, asking Buildbucket for the build status
[03:07:27.624] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:27.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:101:0) after 1m0s
[03:08:27.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:101:0)
[03:08:27.635] Timer tick, asking Buildbucket for the build status
[03:08:27.809] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:27.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:102:0) after 1m0s
[03:09:27.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:102:0)
[03:09:27.830] Timer tick, asking Buildbucket for the build status
[03:09:27.866] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:27.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:103:0) after 1m0s
[03:10:27.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:103:0)
[03:10:27.912] Timer tick, asking Buildbucket for the build status
[03:10:28.039] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:28.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:104:0) after 1m0s
[03:11:28.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:104:0)
[03:11:28.104] Timer tick, asking Buildbucket for the build status
[03:11:28.181] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:28.181] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:105:0) after 1m0s
[03:12:28.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:105:0)
[03:12:28.200] Timer tick, asking Buildbucket for the build status
[03:12:28.235] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:28.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:106:0) after 1m0s
[03:13:28.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:106:0)
[03:13:28.257] Timer tick, asking Buildbucket for the build status
[03:13:29.079] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:29.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:107:0) after 1m0s
[03:14:29.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:107:0)
[03:14:29.142] Timer tick, asking Buildbucket for the build status
[03:14:29.186] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:29.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:108:0) after 1m0s
[03:15:29.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:108:0)
[03:15:29.208] Timer tick, asking Buildbucket for the build status
[03:15:29.379] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:29.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:109:0) after 1m0s
[03:16:29.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:109:0)
[03:16:29.386] Timer tick, asking Buildbucket for the build status
[03:16:30.066] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:30.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:110:0) after 1m0s
[03:17:30.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:110:0)
[03:17:30.070] Timer tick, asking Buildbucket for the build status
[03:17:30.189] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:30.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:111:0) after 1m0s
[03:18:30.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:111:0)
[03:18:30.202] Timer tick, asking Buildbucket for the build status
[03:18:30.263] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:30.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:112:0) after 1m0s
[03:19:30.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:112:0)
[03:19:30.283] Timer tick, asking Buildbucket for the build status
[03:19:30.328] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:30.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:113:0) after 1m0s
[03:20:30.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:113:0)
[03:20:30.355] Timer tick, asking Buildbucket for the build status
[03:20:30.494] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:30.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:114:0) after 1m0s
[03:21:30.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:114:0)
[03:21:30.479] Timer tick, asking Buildbucket for the build status
[03:21:30.538] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:30.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:115:0) after 1m0s
[03:22:30.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:115:0)
[03:22:30.641] Timer tick, asking Buildbucket for the build status
[03:22:30.681] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:30.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:116:0) after 1m0s
[03:23:30.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:116:0)
[03:23:30.722] Timer tick, asking Buildbucket for the build status
[03:23:30.767] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:30.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:117:0) after 1m0s
[03:24:30.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:117:0)
[03:24:30.785] Timer tick, asking Buildbucket for the build status
[03:24:30.882] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:30.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:118:0) after 1m0s
[03:25:30.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:118:0)
[03:25:30.935] Timer tick, asking Buildbucket for the build status
[03:25:30.972] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:30.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:119:0) after 1m0s
[03:26:31.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:119:0)
[03:26:31.007] Timer tick, asking Buildbucket for the build status
[03:26:31.058] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:31.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:120:0) after 1m0s
[03:27:31.081] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:120:0)
[03:27:31.081] Timer tick, asking Buildbucket for the build status
[03:27:31.120] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:31.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:121:0) after 1m0s
[03:28:31.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:121:0)
[03:28:31.119] Timer tick, asking Buildbucket for the build status
[03:28:31.171] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:31.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:122:0) after 1m0s
[03:29:31.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:122:0)
[03:29:31.163] Timer tick, asking Buildbucket for the build status
[03:29:31.264] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:31.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:123:0) after 1m0s
[03:30:31.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:123:0)
[03:30:31.241] Timer tick, asking Buildbucket for the build status
[03:30:31.305] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:31.305] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:124:0) after 1m0s
[03:31:31.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:124:0)
[03:31:31.311] Timer tick, asking Buildbucket for the build status
[03:31:31.347] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:31.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:125:0) after 1m0s
[03:32:31.360] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:125:0)
[03:32:31.360] Timer tick, asking Buildbucket for the build status
[03:32:31.418] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:31.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:126:0) after 1m0s
[03:33:31.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:126:0)
[03:33:31.442] Timer tick, asking Buildbucket for the build status
[03:33:31.479] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:31.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:127:0) after 1m0s
[03:34:31.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:127:0)
[03:34:31.535] Timer tick, asking Buildbucket for the build status
[03:34:31.601] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:31.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:128:0) after 1m0s
[03:35:31.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:128:0)
[03:35:31.623] Timer tick, asking Buildbucket for the build status
[03:35:31.695] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:31.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:129:0) after 1m0s
[03:36:31.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:129:0)
[03:36:31.717] Timer tick, asking Buildbucket for the build status
[03:36:31.932] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:31.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:130:0) after 1m0s
[03:37:31.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:130:0)
[03:37:31.941] Timer tick, asking Buildbucket for the build status
[03:37:32.021] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:32.021] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:131:0) after 1m0s
[03:38:32.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:131:0)
[03:38:32.038] Timer tick, asking Buildbucket for the build status
[03:38:32.109] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:32.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:132:0) after 1m0s
[03:39:32.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:132:0)
[03:39:32.125] Timer tick, asking Buildbucket for the build status
[03:39:32.164] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:32.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:133:0) after 1m0s
[03:40:32.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:133:0)
[03:40:32.141] Timer tick, asking Buildbucket for the build status
[03:40:32.178] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:32.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:134:0) after 1m0s
[03:41:32.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:134:0)
[03:41:32.202] Timer tick, asking Buildbucket for the build status
[03:41:32.273] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:32.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:135:0) after 1m0s
[03:42:32.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:135:0)
[03:42:32.296] Timer tick, asking Buildbucket for the build status
[03:42:32.347] Build 8919775984685463840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:32.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085206046629873456:136:0) after 1m0s
[03:43:05.155] Received PubSub notification, asking Buildbucket for the build status
[03:43:05.266] Build 8919775984685463840: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:43:05.266] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "AUTO",
"completed_ts": "1551843784127923",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551835757516106",
"id": "8919775984685463840",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"74.0.3725.3\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"machine_type\": [\"n1-standard-32\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Build From Tarball\"], \"kvm\": [\"1\"], \"id\": [\"gce-trusty-32-0258d129-us-east1-b-4t5k\"], \"server_version\": [\"4143-92e279d\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"gpu\": [\"none\"], \"cores\": [\"32\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"pool\": [\"luci.infra.cron\"], \"caches\": [\"vpython\"]}}, \"ui\": {\"info\": \"\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"buildername\": \"Build From Tarball\", \"recipe\": \"build_from_tarball\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"version\": \"74.0.3725.3\", \"path_config\": \"generic\", \"bot_id\": \"gce-trusty-32-0258d129-us-east1-b-4t5k\"}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1551835787254372",
"status": "COMPLETED",
"status_changed_ts": "1551843784894856",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9085206046629873456",
"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/8919775984685463840/+/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:43697004d2532610",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1551843784895924",
"url": "https://ci.chromium.org/b/8919775984685463840",
"utcnow_ts": "1551843785258210"
}
}
[03:43:05.266] Invocation finished in 2h13m48.987535425s with status SUCCEEDED