[10:42:06.399] New invocation is queued and will start shortly
[10:42:06.399] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[10:42:07.613] Starting the invocation (attempt 1)
[10:42:07.651] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:42:07.651] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:42:07.651] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9096224095200013616",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"72.0.3601.0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9096224095200013616",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[10:42:09.328] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1541328127747898",
"id": "8930794033077956432",
"lease_expiration_ts": "1541446929119260",
"lease_key": "1509069719",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"72.0.3601.0\"}}",
"project": "infra",
"result_details_json": "null",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1541328129121477",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9096224095200013616",
"scheduler_job_id:infra/Build From Tarball",
"swarming_dimension:builder:Build From Tarball",
"swarming_dimension:caches:builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.infra.cron",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:buildbucket_bucket:infra/cron",
"swarming_tag:buildbucket_build_id:8930794033077956432",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:Build From Tarball",
"swarming_tag:caches:builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2",
"swarming_tag:cpu:x86-64",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8930794033077956432/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:publish_tarball",
"swarming_tag:pool:luci.infra.cron",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:build_from_tarball",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_tag:scheduler_invocation_id:9096224095200013616",
"swarming_tag:scheduler_job_id:infra/Build From Tarball",
"swarming_tag:service_account:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:ec92cebceb578036635bdb39ec91102625e5b767",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40f722525637ea10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1541328129121612",
"url": "https://ci.chromium.org/b/8930794033077956432",
"utcnow_ts": "1541328129308968"
}
}
[10:42:09.328] Task URL: https://ci.chromium.org/b/8930794033077956432
[10:42:09.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:2:0) after 1m0s
[10:42:59.835] Received PubSub notification, asking Buildbucket for the build status
[10:42:59.887] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:09.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:2:0)
[10:43:09.351] Timer tick, asking Buildbucket for the build status
[10:43:09.386] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:09.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:4:0) after 1m0s
[10:44:09.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:4:0)
[10:44:09.405] Timer tick, asking Buildbucket for the build status
[10:44:09.498] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:09.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:5:0) after 1m0s
[10:45:09.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:5:0)
[10:45:09.522] Timer tick, asking Buildbucket for the build status
[10:45:09.698] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:09.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:6:0) after 1m0s
[10:46:09.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:6:0)
[10:46:09.716] Timer tick, asking Buildbucket for the build status
[10:46:10.023] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:10.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:7:0) after 1m0s
[10:47:10.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:7:0)
[10:47:10.045] Timer tick, asking Buildbucket for the build status
[10:47:10.137] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:10.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:8:0) after 1m0s
[10:48:10.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:8:0)
[10:48:10.239] Timer tick, asking Buildbucket for the build status
[10:48:10.309] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:10.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:9:0) after 1m0s
[10:49:10.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:9:0)
[10:49:10.397] Timer tick, asking Buildbucket for the build status
[10:49:10.466] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:10.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:10:0) after 1m0s
[10:50:10.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:10:0)
[10:50:10.652] Timer tick, asking Buildbucket for the build status
[10:50:10.824] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:10.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:11:0) after 1m0s
[10:51:10.888] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:11:0)
[10:51:10.888] Timer tick, asking Buildbucket for the build status
[10:51:10.978] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:10.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:12:0) after 1m0s
[10:52:10.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:12:0)
[10:52:10.996] Timer tick, asking Buildbucket for the build status
[10:52:11.099] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:11.100] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:13:0) after 1m0s
[10:53:11.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:13:0)
[10:53:11.118] Timer tick, asking Buildbucket for the build status
[10:53:11.236] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:11.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:14:0) after 1m0s
[10:54:11.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:14:0)
[10:54:11.254] Timer tick, asking Buildbucket for the build status
[10:54:11.710] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:11.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:15:0) after 1m0s
[10:55:11.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:15:0)
[10:55:11.735] Timer tick, asking Buildbucket for the build status
[10:55:11.801] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:11.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:16:0) after 1m0s
[10:56:11.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:16:0)
[10:56:11.827] Timer tick, asking Buildbucket for the build status
[10:56:11.901] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:11.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:17:0) after 1m0s
[10:57:11.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:17:0)
[10:57:11.918] Timer tick, asking Buildbucket for the build status
[10:57:11.990] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:11.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:18:0) after 1m0s
[10:58:12.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:18:0)
[10:58:12.011] Timer tick, asking Buildbucket for the build status
[10:58:12.087] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:12.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:19:0) after 1m0s
[10:59:12.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:19:0)
[10:59:12.108] Timer tick, asking Buildbucket for the build status
[10:59:12.191] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:12.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:20:0) after 1m0s
[11:00:12.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:20:0)
[11:00:12.208] Timer tick, asking Buildbucket for the build status
[11:00:12.293] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:12.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:21:0) after 1m0s
[11:01:12.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:21:0)
[11:01:12.309] Timer tick, asking Buildbucket for the build status
[11:01:12.386] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:12.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:22:0) after 1m0s
[11:02:12.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:22:0)
[11:02:12.588] Timer tick, asking Buildbucket for the build status
[11:02:12.680] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:12.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:23:0) after 1m0s
[11:03:12.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:23:0)
[11:03:12.874] Timer tick, asking Buildbucket for the build status
[11:03:13.022] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:13.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:24:0) after 1m0s
[11:04:13.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:24:0)
[11:04:13.194] Timer tick, asking Buildbucket for the build status
[11:04:13.263] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:13.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:25:0) after 1m0s
[11:05:13.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:25:0)
[11:05:13.495] Timer tick, asking Buildbucket for the build status
[11:05:13.614] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:13.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:26:0) after 1m0s
[11:06:13.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:26:0)
[11:06:13.861] Timer tick, asking Buildbucket for the build status
[11:06:14.019] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:14.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:27:0) after 1m0s
[11:07:14.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:27:0)
[11:07:14.177] Timer tick, asking Buildbucket for the build status
[11:07:14.671] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:14.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:28:0) after 1m0s
[11:08:14.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:28:0)
[11:08:14.702] Timer tick, asking Buildbucket for the build status
[11:08:14.808] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:14.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:29:0) after 1m0s
[11:09:14.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:29:0)
[11:09:14.916] Timer tick, asking Buildbucket for the build status
[11:09:15.081] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:15.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:30:0) after 1m0s
[11:10:15.100] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:30:0)
[11:10:15.100] Timer tick, asking Buildbucket for the build status
[11:10:15.136] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:15.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:31:0) after 1m0s
[11:11:15.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:31:0)
[11:11:15.216] Timer tick, asking Buildbucket for the build status
[11:11:15.295] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:15.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:32:0) after 1m0s
[11:12:15.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:32:0)
[11:12:15.474] Timer tick, asking Buildbucket for the build status
[11:12:15.536] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:15.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:33:0) after 1m0s
[11:13:15.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:33:0)
[11:13:15.554] Timer tick, asking Buildbucket for the build status
[11:13:15.646] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:15.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:34:0) after 1m0s
[11:14:15.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:34:0)
[11:14:15.667] Timer tick, asking Buildbucket for the build status
[11:14:15.739] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:15.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:35:0) after 1m0s
[11:15:15.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:35:0)
[11:15:15.758] Timer tick, asking Buildbucket for the build status
[11:15:15.853] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:15.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:36:0) after 1m0s
[11:16:15.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:36:0)
[11:16:15.886] Timer tick, asking Buildbucket for the build status
[11:16:15.960] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:15.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:37:0) after 1m0s
[11:17:16.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:37:0)
[11:17:16.004] Timer tick, asking Buildbucket for the build status
[11:17:16.079] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:16.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:38:0) after 1m0s
[11:18:16.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:38:0)
[11:18:16.471] Timer tick, asking Buildbucket for the build status
[11:18:16.534] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:16.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:39:0) after 1m0s
[11:19:16.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:39:0)
[11:19:16.640] Timer tick, asking Buildbucket for the build status
[11:19:16.686] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:16.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:40:0) after 1m0s
[11:20:16.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:40:0)
[11:20:16.903] Timer tick, asking Buildbucket for the build status
[11:20:17.030] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:17.030] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:41:0) after 1m0s
[11:21:17.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:41:0)
[11:21:17.223] Timer tick, asking Buildbucket for the build status
[11:21:17.300] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:17.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:42:0) after 1m0s
[11:22:17.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:42:0)
[11:22:17.482] Timer tick, asking Buildbucket for the build status
[11:22:17.625] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:17.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:43:0) after 1m0s
[11:23:17.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:43:0)
[11:23:17.694] Timer tick, asking Buildbucket for the build status
[11:23:17.842] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:17.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:44:0) after 1m0s
[11:24:17.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:44:0)
[11:24:17.872] Timer tick, asking Buildbucket for the build status
[11:24:17.914] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:17.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:45:0) after 1m0s
[11:25:17.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:45:0)
[11:25:17.932] Timer tick, asking Buildbucket for the build status
[11:25:17.994] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:17.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:46:0) after 1m0s
[11:26:18.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:46:0)
[11:26:18.016] Timer tick, asking Buildbucket for the build status
[11:26:18.084] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:18.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:47:0) after 1m0s
[11:27:18.120] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:47:0)
[11:27:18.120] Timer tick, asking Buildbucket for the build status
[11:27:18.187] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:18.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:48:0) after 1m0s
[11:28:18.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:48:0)
[11:28:18.208] Timer tick, asking Buildbucket for the build status
[11:28:18.251] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:18.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:49:0) after 1m0s
[11:29:18.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:49:0)
[11:29:18.322] Timer tick, asking Buildbucket for the build status
[11:29:18.490] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:18.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:50:0) after 1m0s
[11:30:18.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:50:0)
[11:30:18.647] Timer tick, asking Buildbucket for the build status
[11:30:18.721] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:18.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:51:0) after 1m0s
[11:31:18.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:51:0)
[11:31:18.954] Timer tick, asking Buildbucket for the build status
[11:31:19.167] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:19.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:52:0) after 1m0s
[11:32:19.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:52:0)
[11:32:19.302] Timer tick, asking Buildbucket for the build status
[11:32:19.373] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:19.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:53:0) after 1m0s
[11:33:19.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:53:0)
[11:33:19.608] Timer tick, asking Buildbucket for the build status
[11:33:19.688] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:19.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:54:0) after 1m0s
[11:34:19.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:54:0)
[11:34:19.715] Timer tick, asking Buildbucket for the build status
[11:34:19.777] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:19.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:55:0) after 1m0s
[11:35:19.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:55:0)
[11:35:19.856] Timer tick, asking Buildbucket for the build status
[11:35:20.014] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:20.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:56:0) after 1m0s
[11:36:20.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:56:0)
[11:36:20.034] Timer tick, asking Buildbucket for the build status
[11:36:20.132] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:20.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:57:0) after 1m0s
[11:37:20.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:57:0)
[11:37:20.191] Timer tick, asking Buildbucket for the build status
[11:37:20.287] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:20.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:58:0) after 1m0s
[11:38:20.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:58:0)
[11:38:20.407] Timer tick, asking Buildbucket for the build status
[11:38:20.454] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:20.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:59:0) after 1m0s
[11:39:20.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:59:0)
[11:39:20.618] Timer tick, asking Buildbucket for the build status
[11:39:21.043] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:21.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:60:0) after 1m0s
[11:40:21.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:60:0)
[11:40:21.066] Timer tick, asking Buildbucket for the build status
[11:40:21.311] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:21.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:61:0) after 1m0s
[11:41:21.332] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:61:0)
[11:41:21.332] Timer tick, asking Buildbucket for the build status
[11:41:21.401] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:21.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:62:0) after 1m0s
[11:42:21.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:62:0)
[11:42:21.422] Timer tick, asking Buildbucket for the build status
[11:42:21.605] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:21.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:63:0) after 1m0s
[11:43:21.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:63:0)
[11:43:21.626] Timer tick, asking Buildbucket for the build status
[11:43:21.711] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:21.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:64:0) after 1m0s
[11:44:21.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:64:0)
[11:44:21.797] Timer tick, asking Buildbucket for the build status
[11:44:21.920] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:21.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:65:0) after 1m0s
[11:45:21.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:65:0)
[11:45:21.945] Timer tick, asking Buildbucket for the build status
[11:45:22.022] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:22.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:66:0) after 1m0s
[11:46:22.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:66:0)
[11:46:22.039] Timer tick, asking Buildbucket for the build status
[11:46:22.114] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:22.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:67:0) after 1m0s
[11:47:22.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:67:0)
[11:47:22.135] Timer tick, asking Buildbucket for the build status
[11:47:22.325] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:22.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:68:0) after 1m0s
[11:48:22.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:68:0)
[11:48:22.345] Timer tick, asking Buildbucket for the build status
[11:48:22.523] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:22.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:69:0) after 1m0s
[11:49:22.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:69:0)
[11:49:22.546] Timer tick, asking Buildbucket for the build status
[11:49:22.614] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:22.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:70:0) after 1m0s
[11:50:22.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:70:0)
[11:50:22.641] Timer tick, asking Buildbucket for the build status
[11:50:22.721] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:22.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:71:0) after 1m0s
[11:51:22.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:71:0)
[11:51:22.805] Timer tick, asking Buildbucket for the build status
[11:51:22.863] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:22.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:72:0) after 1m0s
[11:52:22.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:72:0)
[11:52:22.985] Timer tick, asking Buildbucket for the build status
[11:52:23.076] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:23.076] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:73:0) after 1m0s
[11:53:23.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:73:0)
[11:53:23.208] Timer tick, asking Buildbucket for the build status
[11:53:23.369] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:23.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:74:0) after 1m0s
[11:54:23.524] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:74:0)
[11:54:23.524] Timer tick, asking Buildbucket for the build status
[11:54:23.604] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:23.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:75:0) after 1m0s
[11:55:23.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:75:0)
[11:55:23.645] Timer tick, asking Buildbucket for the build status
[11:55:23.749] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:23.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:76:0) after 1m0s
[11:56:23.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:76:0)
[11:56:23.874] Timer tick, asking Buildbucket for the build status
[11:56:23.943] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:23.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:77:0) after 1m0s
[11:57:24.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:77:0)
[11:57:24.069] Timer tick, asking Buildbucket for the build status
[11:57:24.296] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:24.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:78:0) after 1m0s
[11:58:24.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:78:0)
[11:58:24.384] Timer tick, asking Buildbucket for the build status
[11:58:24.471] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:24.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:79:0) after 1m0s
[11:59:24.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:79:0)
[11:59:24.592] Timer tick, asking Buildbucket for the build status
[11:59:24.637] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:24.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:80:0) after 1m0s
[12:00:24.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:80:0)
[12:00:24.727] Timer tick, asking Buildbucket for the build status
[12:00:24.788] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:24.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:81:0) after 1m0s
[12:01:24.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:81:0)
[12:01:24.837] Timer tick, asking Buildbucket for the build status
[12:01:24.912] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:24.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:82:0) after 1m0s
[12:02:24.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:82:0)
[12:02:24.991] Timer tick, asking Buildbucket for the build status
[12:02:25.051] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:25.051] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:83:0) after 1m0s
[12:03:25.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:83:0)
[12:03:25.166] Timer tick, asking Buildbucket for the build status
[12:03:25.237] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:25.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:84:0) after 1m0s
[12:04:25.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:84:0)
[12:04:25.362] Timer tick, asking Buildbucket for the build status
[12:04:25.534] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:25.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:85:0) after 1m0s
[12:05:25.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:85:0)
[12:05:25.701] Timer tick, asking Buildbucket for the build status
[12:05:25.771] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:25.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:86:0) after 1m0s
[12:06:25.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:86:0)
[12:06:25.868] Timer tick, asking Buildbucket for the build status
[12:06:25.928] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:25.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:87:0) after 1m0s
[12:07:26.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:87:0)
[12:07:26.107] Timer tick, asking Buildbucket for the build status
[12:07:26.174] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:26.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:88:0) after 1m0s
[12:08:26.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:88:0)
[12:08:26.297] Timer tick, asking Buildbucket for the build status
[12:08:26.409] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:26.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:89:0) after 1m0s
[12:09:26.509] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:89:0)
[12:09:26.509] Timer tick, asking Buildbucket for the build status
[12:09:26.585] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:26.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:90:0) after 1m0s
[12:10:26.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:90:0)
[12:10:26.627] Timer tick, asking Buildbucket for the build status
[12:10:26.665] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:26.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:91:0) after 1m0s
[12:11:26.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:91:0)
[12:11:26.750] Timer tick, asking Buildbucket for the build status
[12:11:26.833] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:26.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:92:0) after 1m0s
[12:12:27.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:92:0)
[12:12:27.018] Timer tick, asking Buildbucket for the build status
[12:12:27.212] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:27.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:93:0) after 1m0s
[12:13:27.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:93:0)
[12:13:27.248] Timer tick, asking Buildbucket for the build status
[12:13:27.664] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:27.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:94:0) after 1m0s
[12:14:27.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:94:0)
[12:14:27.683] Timer tick, asking Buildbucket for the build status
[12:14:27.747] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:27.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:95:0) after 1m0s
[12:15:27.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:95:0)
[12:15:27.798] Timer tick, asking Buildbucket for the build status
[12:15:27.959] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:27.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:96:0) after 1m0s
[12:16:27.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:96:0)
[12:16:27.991] Timer tick, asking Buildbucket for the build status
[12:16:28.185] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:28.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:97:0) after 1m0s
[12:17:28.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:97:0)
[12:17:28.204] Timer tick, asking Buildbucket for the build status
[12:17:28.292] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:28.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:98:0) after 1m0s
[12:18:28.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:98:0)
[12:18:28.312] Timer tick, asking Buildbucket for the build status
[12:18:28.405] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:28.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:99:0) after 1m0s
[12:19:28.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:99:0)
[12:19:28.490] Timer tick, asking Buildbucket for the build status
[12:19:28.573] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:28.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:100:0) after 1m0s
[12:20:28.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:100:0)
[12:20:28.666] Timer tick, asking Buildbucket for the build status
[12:20:28.727] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:28.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:101:0) after 1m0s
[12:21:28.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:101:0)
[12:21:28.849] Timer tick, asking Buildbucket for the build status
[12:21:28.955] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:28.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:102:0) after 1m0s
[12:22:29.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:102:0)
[12:22:29.055] Timer tick, asking Buildbucket for the build status
[12:22:29.125] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:29.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:103:0) after 1m0s
[12:23:29.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:103:0)
[12:23:29.303] Timer tick, asking Buildbucket for the build status
[12:23:29.397] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:29.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:104:0) after 1m0s
[12:24:29.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:104:0)
[12:24:29.514] Timer tick, asking Buildbucket for the build status
[12:24:29.576] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:29.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:105:0) after 1m0s
[12:25:29.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:105:0)
[12:25:29.704] Timer tick, asking Buildbucket for the build status
[12:25:29.890] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:29.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:106:0) after 1m0s
[12:26:29.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:106:0)
[12:26:29.958] Timer tick, asking Buildbucket for the build status
[12:26:30.045] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:30.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:107:0) after 1m0s
[12:27:30.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:107:0)
[12:27:30.097] Timer tick, asking Buildbucket for the build status
[12:27:30.200] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:30.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:108:0) after 1m0s
[12:28:30.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:108:0)
[12:28:30.225] Timer tick, asking Buildbucket for the build status
[12:28:30.389] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:30.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:109:0) after 1m0s
[12:29:30.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:109:0)
[12:29:30.438] Timer tick, asking Buildbucket for the build status
[12:29:30.514] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:30.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:110:0) after 1m0s
[12:30:30.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:110:0)
[12:30:30.533] Timer tick, asking Buildbucket for the build status
[12:30:30.600] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:30.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:111:0) after 1m0s
[12:31:30.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:111:0)
[12:31:30.627] Timer tick, asking Buildbucket for the build status
[12:31:30.692] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:30.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:112:0) after 1m0s
[12:32:30.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:112:0)
[12:32:30.718] Timer tick, asking Buildbucket for the build status
[12:32:30.789] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:30.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:113:0) after 1m0s
[12:33:30.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:113:0)
[12:33:30.810] Timer tick, asking Buildbucket for the build status
[12:33:30.909] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:30.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:114:0) after 1m0s
[12:34:30.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:114:0)
[12:34:30.935] Timer tick, asking Buildbucket for the build status
[12:34:31.003] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:31.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:115:0) after 1m0s
[12:35:31.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:115:0)
[12:35:31.097] Timer tick, asking Buildbucket for the build status
[12:35:31.162] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:31.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:116:0) after 1m0s
[12:36:31.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:116:0)
[12:36:31.182] Timer tick, asking Buildbucket for the build status
[12:36:31.268] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:31.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:117:0) after 1m0s
[12:37:31.399] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:117:0)
[12:37:31.399] Timer tick, asking Buildbucket for the build status
[12:37:31.491] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:31.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:118:0) after 1m0s
[12:38:32.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:118:0)
[12:38:32.257] Timer tick, asking Buildbucket for the build status
[12:38:32.438] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:32.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:119:0) after 1m0s
[12:39:32.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:119:0)
[12:39:32.526] Timer tick, asking Buildbucket for the build status
[12:39:32.686] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:32.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:120:0) after 1m0s
[12:40:32.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:120:0)
[12:40:32.737] Timer tick, asking Buildbucket for the build status
[12:40:32.798] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:32.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:121:0) after 1m0s
[12:41:32.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:121:0)
[12:41:32.833] Timer tick, asking Buildbucket for the build status
[12:41:32.907] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:32.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:122:0) after 1m0s
[12:42:32.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:122:0)
[12:42:32.981] Timer tick, asking Buildbucket for the build status
[12:42:33.183] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:33.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:123:0) after 1m0s
[12:43:33.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:123:0)
[12:43:33.205] Timer tick, asking Buildbucket for the build status
[12:43:33.268] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:33.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:124:0) after 1m0s
[12:44:33.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:124:0)
[12:44:33.364] Timer tick, asking Buildbucket for the build status
[12:44:33.437] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:33.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:125:0) after 1m0s
[12:45:33.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:125:0)
[12:45:33.468] Timer tick, asking Buildbucket for the build status
[12:45:33.533] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:33.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:126:0) after 1m0s
[12:46:33.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:126:0)
[12:46:33.556] Timer tick, asking Buildbucket for the build status
[12:46:33.754] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:33.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:127:0) after 1m0s
[12:47:33.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:127:0)
[12:47:33.775] Timer tick, asking Buildbucket for the build status
[12:47:33.834] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:33.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:128:0) after 1m0s
[12:48:33.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:128:0)
[12:48:33.907] Timer tick, asking Buildbucket for the build status
[12:48:33.974] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:33.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:129:0) after 1m0s
[12:49:34.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:129:0)
[12:49:34.296] Timer tick, asking Buildbucket for the build status
[12:49:34.468] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:34.468] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:130:0) after 1m0s
[12:50:34.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:130:0)
[12:50:34.488] Timer tick, asking Buildbucket for the build status
[12:50:34.607] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:34.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:131:0) after 1m0s
[12:51:34.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:131:0)
[12:51:34.629] Timer tick, asking Buildbucket for the build status
[12:51:34.822] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:34.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:132:0) after 1m0s
[12:52:34.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:132:0)
[12:52:34.842] Timer tick, asking Buildbucket for the build status
[12:52:34.996] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:34.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:133:0) after 1m0s
[12:53:35.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:133:0)
[12:53:35.018] Timer tick, asking Buildbucket for the build status
[12:53:35.090] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:35.090] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:134:0) after 1m0s
[12:54:35.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:134:0)
[12:54:35.108] Timer tick, asking Buildbucket for the build status
[12:54:35.355] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:35.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:135:0) after 1m0s
[12:55:38.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:135:0)
[12:55:38.842] Timer tick, asking Buildbucket for the build status
[12:55:38.930] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:38.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:136:0) after 1m0s
[12:56:38.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:136:0)
[12:56:38.997] Timer tick, asking Buildbucket for the build status
[12:56:39.089] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:39.089] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:137:0) after 1m0s
[12:57:39.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:137:0)
[12:57:39.192] Timer tick, asking Buildbucket for the build status
[12:57:39.350] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:39.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:138:0) after 1m0s
[12:58:39.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:138:0)
[12:58:39.452] Timer tick, asking Buildbucket for the build status
[12:58:39.572] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:39.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:139:0) after 1m0s
[12:59:39.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:139:0)
[12:59:39.656] Timer tick, asking Buildbucket for the build status
[12:59:39.929] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:39.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:140:0) after 1m0s
[13:00:40.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:140:0)
[13:00:40.012] Timer tick, asking Buildbucket for the build status
[13:00:40.098] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:40.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:141:0) after 1m0s
[13:01:40.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:141:0)
[13:01:40.416] Timer tick, asking Buildbucket for the build status
[13:01:40.615] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:40.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:142:0) after 1m0s
[13:02:40.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:142:0)
[13:02:40.648] Timer tick, asking Buildbucket for the build status
[13:02:40.754] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:40.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:143:0) after 1m0s
[13:03:40.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:143:0)
[13:03:40.786] Timer tick, asking Buildbucket for the build status
[13:03:41.038] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:41.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:144:0) after 1m0s
[13:04:41.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:144:0)
[13:04:41.058] Timer tick, asking Buildbucket for the build status
[13:04:41.286] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:41.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:145:0) after 1m0s
[13:05:41.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:145:0)
[13:05:41.312] Timer tick, asking Buildbucket for the build status
[13:05:41.406] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:41.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:146:0) after 1m0s
[13:06:41.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:146:0)
[13:06:41.435] Timer tick, asking Buildbucket for the build status
[13:06:41.524] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:41.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:147:0) after 1m0s
[13:07:41.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:147:0)
[13:07:41.658] Timer tick, asking Buildbucket for the build status
[13:07:41.730] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:41.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:148:0) after 1m0s
[13:08:41.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:148:0)
[13:08:41.761] Timer tick, asking Buildbucket for the build status
[13:08:41.844] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:41.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:149:0) after 1m0s
[13:09:41.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:149:0)
[13:09:41.960] Timer tick, asking Buildbucket for the build status
[13:09:42.049] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:42.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:150:0) after 1m0s
[13:10:42.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:150:0)
[13:10:42.148] Timer tick, asking Buildbucket for the build status
[13:10:42.341] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:42.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:151:0) after 1m0s
[13:11:42.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:151:0)
[13:11:42.411] Timer tick, asking Buildbucket for the build status
[13:11:42.629] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:42.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:152:0) after 1m0s
[13:12:42.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:152:0)
[13:12:42.727] Timer tick, asking Buildbucket for the build status
[13:12:42.848] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:42.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:153:0) after 1m0s
[13:13:42.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:153:0)
[13:13:42.874] Timer tick, asking Buildbucket for the build status
[13:13:42.948] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:42.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:154:0) after 1m0s
[13:14:42.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:154:0)
[13:14:42.975] Timer tick, asking Buildbucket for the build status
[13:14:43.260] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:43.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:155:0) after 1m0s
[13:15:43.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:155:0)
[13:15:43.284] Timer tick, asking Buildbucket for the build status
[13:15:43.535] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:43.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:156:0) after 1m0s
[13:16:43.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:156:0)
[13:16:43.555] Timer tick, asking Buildbucket for the build status
[13:16:43.607] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:43.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:157:0) after 1m0s
[13:17:43.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:157:0)
[13:17:43.629] Timer tick, asking Buildbucket for the build status
[13:17:43.732] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:43.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:158:0) after 1m0s
[13:18:43.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:158:0)
[13:18:43.788] Timer tick, asking Buildbucket for the build status
[13:18:43.885] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:43.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:159:0) after 1m0s
[13:19:43.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:159:0)
[13:19:43.909] Timer tick, asking Buildbucket for the build status
[13:19:43.973] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:43.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:160:0) after 1m0s
[13:20:43.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:160:0)
[13:20:43.998] Timer tick, asking Buildbucket for the build status
[13:20:44.126] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:44.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:161:0) after 1m0s
[13:21:44.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:161:0)
[13:21:44.174] Timer tick, asking Buildbucket for the build status
[13:21:44.216] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:44.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:162:0) after 1m0s
[13:22:44.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:162:0)
[13:22:44.287] Timer tick, asking Buildbucket for the build status
[13:22:44.386] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:44.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:163:0) after 1m0s
[13:23:44.456] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:163:0)
[13:23:44.456] Timer tick, asking Buildbucket for the build status
[13:23:44.553] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:44.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:164:0) after 1m0s
[13:24:44.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:164:0)
[13:24:44.575] Timer tick, asking Buildbucket for the build status
[13:24:44.755] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:44.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:165:0) after 1m0s
[13:25:44.792] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:165:0)
[13:25:44.792] Timer tick, asking Buildbucket for the build status
[13:25:44.928] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:44.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:166:0) after 1m0s
[13:26:44.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:166:0)
[13:26:44.977] Timer tick, asking Buildbucket for the build status
[13:26:45.200] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:45.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:167:0) after 1m0s
[13:27:45.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:167:0)
[13:27:45.302] Timer tick, asking Buildbucket for the build status
[13:27:45.435] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:45.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:168:0) after 1m0s
[13:28:45.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:168:0)
[13:28:45.459] Timer tick, asking Buildbucket for the build status
[13:28:45.540] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:45.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:169:0) after 1m0s
[13:29:45.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:169:0)
[13:29:45.562] Timer tick, asking Buildbucket for the build status
[13:29:45.681] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:45.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:170:0) after 1m0s
[13:30:45.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:170:0)
[13:30:45.744] Timer tick, asking Buildbucket for the build status
[13:30:45.820] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:45.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:171:0) after 1m0s
[13:31:45.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:171:0)
[13:31:45.842] Timer tick, asking Buildbucket for the build status
[13:31:45.897] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:45.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:172:0) after 1m0s
[13:32:45.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:172:0)
[13:32:45.921] Timer tick, asking Buildbucket for the build status
[13:32:45.987] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:45.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:173:0) after 1m0s
[13:33:46.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:173:0)
[13:33:46.191] Timer tick, asking Buildbucket for the build status
[13:33:46.290] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:46.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:174:0) after 1m0s
[13:34:46.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:174:0)
[13:34:46.413] Timer tick, asking Buildbucket for the build status
[13:34:46.469] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:46.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:175:0) after 1m0s
[13:35:46.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:175:0)
[13:35:46.547] Timer tick, asking Buildbucket for the build status
[13:35:46.687] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:46.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:176:0) after 1m0s
[13:36:46.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:176:0)
[13:36:46.788] Timer tick, asking Buildbucket for the build status
[13:36:46.886] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:46.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:177:0) after 1m0s
[13:37:46.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:177:0)
[13:37:46.933] Timer tick, asking Buildbucket for the build status
[13:37:47.041] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:47.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:178:0) after 1m0s
[13:38:47.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:178:0)
[13:38:47.145] Timer tick, asking Buildbucket for the build status
[13:38:47.210] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:47.210] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:179:0) after 1m0s
[13:39:47.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:179:0)
[13:39:47.299] Timer tick, asking Buildbucket for the build status
[13:39:47.376] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:47.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:180:0) after 1m0s
[13:40:47.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:180:0)
[13:40:47.398] Timer tick, asking Buildbucket for the build status
[13:40:47.465] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:47.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:181:0) after 1m0s
[13:41:47.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:181:0)
[13:41:47.492] Timer tick, asking Buildbucket for the build status
[13:41:47.621] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:47.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:182:0) after 1m0s
[13:42:47.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:182:0)
[13:42:47.712] Timer tick, asking Buildbucket for the build status
[13:42:47.772] Build 8930794033077956432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:47.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096224095200013616:183:0) after 1m0s
[13:43:27.177] Received PubSub notification, asking Buildbucket for the build status
[13:43:27.495] Build 8930794033077956432: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[13:43:27.495] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "AUTO",
"completed_ts": "1541339005848236",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1541328127747898",
"failure_reason": "INFRA_FAILURE",
"id": "8930794033077956432",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"72.0.3601.0\"}}",
"project": "infra",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Build From Tarball\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3817-6aedaff\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-e833d7b0-us-west1-b-3w45\"], \"pool\": [\"luci.infra.cron\"]}}, \"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1541328178149924",
"status": "COMPLETED",
"status_changed_ts": "1541339006298711",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9096224095200013616",
"scheduler_job_id:infra/Build From Tarball",
"swarming_dimension:builder:Build From Tarball",
"swarming_dimension:caches:builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.infra.cron",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:buildbucket_bucket:infra/cron",
"swarming_tag:buildbucket_build_id:8930794033077956432",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:Build From Tarball",
"swarming_tag:caches:builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2",
"swarming_tag:cpu:x86-64",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8930794033077956432/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:publish_tarball",
"swarming_tag:pool:luci.infra.cron",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:build_from_tarball",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_tag:scheduler_invocation_id:9096224095200013616",
"swarming_tag:scheduler_job_id:infra/Build From Tarball",
"swarming_tag:service_account:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:ec92cebceb578036635bdb39ec91102625e5b767",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40f722525637ea10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1541339006299845",
"url": "https://ci.chromium.org/b/8930794033077956432",
"utcnow_ts": "1541339007457272"
}
}
[13:43:27.495] Invocation finished in 3h1m21.155351556s with status FAILED