[22:43:00.369] New invocation is queued and will start shortly
[22:43:00.369] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[22:43:01.524] Starting the invocation (attempt 1)
[22:43:01.615] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:43:01.615] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:43:01.615] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9084491731414553232",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"74.0.3729.6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9084491731414553232",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[22:43:04.097] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552516983086578",
"id": "8919061667901801200",
"lease_expiration_ts": "1552635783977070",
"lease_key": "1764507742",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"74.0.3729.6\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1552516983978390",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9084491731414553232",
"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/8919061667901801200/+/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:43920ab24e4d3810",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1552516983978479",
"url": "https://ci.chromium.org/b/8919061667901801200",
"utcnow_ts": "1552516984088183"
}
}
[22:43:04.097] Task URL: https://ci.chromium.org/b/8919061667901801200
[22:43:04.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:2:0) after 1m0s
[22:43:58.205] Received PubSub notification, asking Buildbucket for the build status
[22:43:58.247] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:04.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:2:0)
[22:44:04.123] Timer tick, asking Buildbucket for the build status
[22:44:04.182] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:04.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:4:0) after 1m0s
[22:45:04.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:4:0)
[22:45:04.194] Timer tick, asking Buildbucket for the build status
[22:45:04.276] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:04.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:5:0) after 1m0s
[22:46:04.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:5:0)
[22:46:04.253] Timer tick, asking Buildbucket for the build status
[22:46:04.415] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:04.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:6:0) after 1m0s
[22:47:04.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:6:0)
[22:47:04.433] Timer tick, asking Buildbucket for the build status
[22:47:04.559] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:04.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:7:0) after 1m0s
[22:48:04.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:7:0)
[22:48:04.535] Timer tick, asking Buildbucket for the build status
[22:48:04.603] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:04.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:8:0) after 1m0s
[22:49:04.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:8:0)
[22:49:04.610] Timer tick, asking Buildbucket for the build status
[22:49:04.649] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:04.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:9:0) after 1m0s
[22:50:04.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:9:0)
[22:50:04.637] Timer tick, asking Buildbucket for the build status
[22:50:04.795] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:04.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:10:0) after 1m0s
[22:51:04.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:10:0)
[22:51:04.770] Timer tick, asking Buildbucket for the build status
[22:51:04.872] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:04.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:11:0) after 1m0s
[22:52:04.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:11:0)
[22:52:04.897] Timer tick, asking Buildbucket for the build status
[22:52:04.936] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:04.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:12:0) after 1m0s
[22:53:04.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:12:0)
[22:53:04.908] Timer tick, asking Buildbucket for the build status
[22:53:04.945] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:04.945] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:13:0) after 1m0s
[22:54:04.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:13:0)
[22:54:04.964] Timer tick, asking Buildbucket for the build status
[22:54:05.011] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:05.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:14:0) after 1m0s
[22:55:05.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:14:0)
[22:55:05.029] Timer tick, asking Buildbucket for the build status
[22:55:05.118] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:05.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:15:0) after 1m0s
[22:56:05.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:15:0)
[22:56:05.137] Timer tick, asking Buildbucket for the build status
[22:56:05.199] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:05.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:16:0) after 1m0s
[22:57:05.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:16:0)
[22:57:05.173] Timer tick, asking Buildbucket for the build status
[22:57:05.211] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:05.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:17:0) after 1m0s
[22:58:05.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:17:0)
[22:58:05.199] Timer tick, asking Buildbucket for the build status
[22:58:05.291] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:05.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:18:0) after 1m0s
[22:59:05.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:18:0)
[22:59:05.263] Timer tick, asking Buildbucket for the build status
[22:59:05.309] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:05.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:19:0) after 1m0s
[23:00:05.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:19:0)
[23:00:05.330] Timer tick, asking Buildbucket for the build status
[23:00:05.534] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:05.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:20:0) after 1m0s
[23:01:05.504] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:20:0)
[23:01:05.504] Timer tick, asking Buildbucket for the build status
[23:01:05.563] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:05.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:21:0) after 1m0s
[23:02:05.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:21:0)
[23:02:05.580] Timer tick, asking Buildbucket for the build status
[23:02:05.626] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:05.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:22:0) after 1m0s
[23:03:05.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:22:0)
[23:03:05.618] Timer tick, asking Buildbucket for the build status
[23:03:05.652] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:05.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:23:0) after 1m0s
[23:04:05.643] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:23:0)
[23:04:05.643] Timer tick, asking Buildbucket for the build status
[23:04:05.814] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:05.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:24:0) after 1m0s
[23:05:05.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:24:0)
[23:05:05.819] Timer tick, asking Buildbucket for the build status
[23:05:06.016] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:06.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:25:0) after 1m0s
[23:06:06.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:25:0)
[23:06:06.028] Timer tick, asking Buildbucket for the build status
[23:06:06.074] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:06.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:26:0) after 1m0s
[23:07:06.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:26:0)
[23:07:06.096] Timer tick, asking Buildbucket for the build status
[23:07:06.163] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:06.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:27:0) after 1m0s
[23:08:06.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:27:0)
[23:08:06.181] Timer tick, asking Buildbucket for the build status
[23:08:06.217] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:06.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:28:0) after 1m0s
[23:09:06.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:28:0)
[23:09:06.234] Timer tick, asking Buildbucket for the build status
[23:09:06.277] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:06.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:29:0) after 1m0s
[23:10:06.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:29:0)
[23:10:06.295] Timer tick, asking Buildbucket for the build status
[23:10:06.427] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:06.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:30:0) after 1m0s
[23:11:06.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:30:0)
[23:11:06.404] Timer tick, asking Buildbucket for the build status
[23:11:06.447] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:06.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:31:0) after 1m0s
[23:12:06.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:31:0)
[23:12:06.468] Timer tick, asking Buildbucket for the build status
[23:12:06.522] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:06.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:32:0) after 1m0s
[23:13:06.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:32:0)
[23:13:06.497] Timer tick, asking Buildbucket for the build status
[23:13:06.546] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:06.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:33:0) after 1m0s
[23:14:06.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:33:0)
[23:14:06.567] Timer tick, asking Buildbucket for the build status
[23:14:06.602] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:06.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:34:0) after 1m0s
[23:15:06.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:34:0)
[23:15:06.612] Timer tick, asking Buildbucket for the build status
[23:15:06.659] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:06.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:35:0) after 1m0s
[23:16:06.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:35:0)
[23:16:06.665] Timer tick, asking Buildbucket for the build status
[23:16:06.725] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:06.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:36:0) after 1m0s
[23:17:06.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:36:0)
[23:17:06.745] Timer tick, asking Buildbucket for the build status
[23:17:06.806] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:06.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:37:0) after 1m0s
[23:18:06.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:37:0)
[23:18:06.827] Timer tick, asking Buildbucket for the build status
[23:18:06.885] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:06.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:38:0) after 1m0s
[23:19:06.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:38:0)
[23:19:06.886] Timer tick, asking Buildbucket for the build status
[23:19:06.983] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:06.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:39:0) after 1m0s
[23:20:07.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:39:0)
[23:20:07.002] Timer tick, asking Buildbucket for the build status
[23:20:07.046] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:07.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:40:0) after 1m0s
[23:21:07.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:40:0)
[23:21:07.083] Timer tick, asking Buildbucket for the build status
[23:21:07.132] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:07.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:41:0) after 1m0s
[23:22:07.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:41:0)
[23:22:07.152] Timer tick, asking Buildbucket for the build status
[23:22:07.230] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:07.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:42:0) after 1m0s
[23:23:07.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:42:0)
[23:23:07.231] Timer tick, asking Buildbucket for the build status
[23:23:07.289] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:07.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:43:0) after 1m0s
[23:24:07.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:43:0)
[23:24:07.308] Timer tick, asking Buildbucket for the build status
[23:24:07.346] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:07.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:44:0) after 1m0s
[23:25:07.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:44:0)
[23:25:07.364] Timer tick, asking Buildbucket for the build status
[23:25:07.424] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:07.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:45:0) after 1m0s
[23:26:07.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:45:0)
[23:26:07.416] Timer tick, asking Buildbucket for the build status
[23:26:07.466] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:07.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:46:0) after 1m0s
[23:27:07.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:46:0)
[23:27:07.484] Timer tick, asking Buildbucket for the build status
[23:27:07.595] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:07.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:47:0) after 1m0s
[23:28:07.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:47:0)
[23:28:07.584] Timer tick, asking Buildbucket for the build status
[23:28:07.696] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:07.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:48:0) after 1m0s
[23:29:07.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:48:0)
[23:29:07.695] Timer tick, asking Buildbucket for the build status
[23:29:07.850] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:07.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:49:0) after 1m0s
[23:30:07.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:49:0)
[23:30:07.846] Timer tick, asking Buildbucket for the build status
[23:30:07.897] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:07.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:50:0) after 1m0s
[23:31:07.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:50:0)
[23:31:07.873] Timer tick, asking Buildbucket for the build status
[23:31:07.921] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:07.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:51:0) after 1m0s
[23:32:07.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:51:0)
[23:32:07.895] Timer tick, asking Buildbucket for the build status
[23:32:07.974] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:07.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:52:0) after 1m0s
[23:33:07.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:52:0)
[23:33:07.955] Timer tick, asking Buildbucket for the build status
[23:33:08.055] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:08.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:53:0) after 1m0s
[23:34:08.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:53:0)
[23:34:08.075] Timer tick, asking Buildbucket for the build status
[23:34:08.163] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:08.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:54:0) after 1m0s
[23:35:08.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:54:0)
[23:35:08.179] Timer tick, asking Buildbucket for the build status
[23:35:08.225] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:08.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:55:0) after 1m0s
[23:36:08.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:55:0)
[23:36:08.247] Timer tick, asking Buildbucket for the build status
[23:36:08.288] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:08.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:56:0) after 1m0s
[23:37:08.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:56:0)
[23:37:08.297] Timer tick, asking Buildbucket for the build status
[23:37:08.379] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:08.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:57:0) after 1m0s
[23:38:08.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:57:0)
[23:38:08.434] Timer tick, asking Buildbucket for the build status
[23:38:08.470] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:08.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:58:0) after 1m0s
[23:39:08.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:58:0)
[23:39:08.489] Timer tick, asking Buildbucket for the build status
[23:39:08.608] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:08.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:59:0) after 1m0s
[23:40:08.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:59:0)
[23:40:08.627] Timer tick, asking Buildbucket for the build status
[23:40:08.677] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:08.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:60:0) after 1m0s
[23:41:08.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:60:0)
[23:41:08.698] Timer tick, asking Buildbucket for the build status
[23:41:08.834] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:08.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:61:0) after 1m0s
[23:42:08.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:61:0)
[23:42:08.852] Timer tick, asking Buildbucket for the build status
[23:42:08.956] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:08.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:62:0) after 1m0s
[23:43:08.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:62:0)
[23:43:08.983] Timer tick, asking Buildbucket for the build status
[23:43:09.032] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:09.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:63:0) after 1m0s
[23:44:09.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:63:0)
[23:44:09.055] Timer tick, asking Buildbucket for the build status
[23:44:09.091] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:09.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:64:0) after 1m0s
[23:45:09.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:64:0)
[23:45:09.200] Timer tick, asking Buildbucket for the build status
[23:45:09.258] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:09.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:65:0) after 1m0s
[23:46:09.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:65:0)
[23:46:09.244] Timer tick, asking Buildbucket for the build status
[23:46:09.287] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:09.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:66:0) after 1m0s
[23:47:09.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:66:0)
[23:47:09.285] Timer tick, asking Buildbucket for the build status
[23:47:09.578] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:09.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:67:0) after 1m0s
[23:48:09.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:67:0)
[23:48:09.598] Timer tick, asking Buildbucket for the build status
[23:48:09.632] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:09.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:68:0) after 1m0s
[23:49:09.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:68:0)
[23:49:09.655] Timer tick, asking Buildbucket for the build status
[23:49:09.706] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:09.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:69:0) after 1m0s
[23:50:09.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:69:0)
[23:50:09.730] Timer tick, asking Buildbucket for the build status
[23:50:09.775] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:09.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:70:0) after 1m0s
[23:51:09.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:70:0)
[23:51:09.766] Timer tick, asking Buildbucket for the build status
[23:51:09.801] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:09.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:71:0) after 1m0s
[23:52:09.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:71:0)
[23:52:09.827] Timer tick, asking Buildbucket for the build status
[23:52:09.968] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:09.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:72:0) after 1m0s
[23:53:10.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:72:0)
[23:53:10.020] Timer tick, asking Buildbucket for the build status
[23:53:10.157] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:10.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:73:0) after 1m0s
[23:54:10.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:73:0)
[23:54:10.167] Timer tick, asking Buildbucket for the build status
[23:54:10.211] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:10.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:74:0) after 1m0s
[23:55:10.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:74:0)
[23:55:10.206] Timer tick, asking Buildbucket for the build status
[23:55:10.320] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:10.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:75:0) after 1m0s
[23:56:10.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:75:0)
[23:56:10.339] Timer tick, asking Buildbucket for the build status
[23:56:10.458] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:10.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:76:0) after 1m0s
[23:57:10.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:76:0)
[23:57:10.436] Timer tick, asking Buildbucket for the build status
[23:57:10.470] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:10.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:77:0) after 1m0s
[23:58:10.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:77:0)
[23:58:10.490] Timer tick, asking Buildbucket for the build status
[23:58:10.523] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:10.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:78:0) after 1m0s
[23:59:10.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:78:0)
[23:59:10.508] Timer tick, asking Buildbucket for the build status
[23:59:10.594] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:10.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:79:0) after 1m0s
[00:00:10.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:79:0)
[00:00:10.589] Timer tick, asking Buildbucket for the build status
[00:00:10.694] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:10.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:80:0) after 1m0s
[00:01:10.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:80:0)
[00:01:10.704] Timer tick, asking Buildbucket for the build status
[00:01:10.948] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:10.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:81:0) after 1m0s
[00:02:10.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:81:0)
[00:02:10.971] Timer tick, asking Buildbucket for the build status
[00:02:12.119] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:12.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:82:0) after 1m0s
[00:03:12.136] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:82:0)
[00:03:12.136] Timer tick, asking Buildbucket for the build status
[00:03:12.320] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:12.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:83:0) after 1m0s
[00:04:12.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:83:0)
[00:04:12.318] Timer tick, asking Buildbucket for the build status
[00:04:12.357] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:12.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:84:0) after 1m0s
[00:05:12.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:84:0)
[00:05:12.375] Timer tick, asking Buildbucket for the build status
[00:05:12.615] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:12.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:85:0) after 1m0s
[00:06:12.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:85:0)
[00:06:12.627] Timer tick, asking Buildbucket for the build status
[00:06:12.751] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:12.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:86:0) after 1m0s
[00:07:12.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:86:0)
[00:07:12.771] Timer tick, asking Buildbucket for the build status
[00:07:12.828] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:12.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:87:0) after 1m0s
[00:08:12.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:87:0)
[00:08:12.812] Timer tick, asking Buildbucket for the build status
[00:08:12.843] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:12.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:88:0) after 1m0s
[00:09:12.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:88:0)
[00:09:12.812] Timer tick, asking Buildbucket for the build status
[00:09:12.964] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:12.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:89:0) after 1m0s
[00:10:12.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:89:0)
[00:10:12.965] Timer tick, asking Buildbucket for the build status
[00:10:13.022] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:13.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:90:0) after 1m0s
[00:11:13.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:90:0)
[00:11:13.043] Timer tick, asking Buildbucket for the build status
[00:11:13.183] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:13.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:91:0) after 1m0s
[00:12:13.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:91:0)
[00:12:13.212] Timer tick, asking Buildbucket for the build status
[00:12:13.341] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:13.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:92:0) after 1m0s
[00:13:13.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:92:0)
[00:13:13.356] Timer tick, asking Buildbucket for the build status
[00:13:13.453] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:13.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:93:0) after 1m0s
[00:14:13.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:93:0)
[00:14:13.481] Timer tick, asking Buildbucket for the build status
[00:14:13.520] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:13.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:94:0) after 1m0s
[00:15:13.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:94:0)
[00:15:13.552] Timer tick, asking Buildbucket for the build status
[00:15:13.758] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:13.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:95:0) after 1m0s
[00:16:13.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:95:0)
[00:16:13.785] Timer tick, asking Buildbucket for the build status
[00:16:13.973] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:13.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:96:0) after 1m0s
[00:17:13.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:96:0)
[00:17:13.953] Timer tick, asking Buildbucket for the build status
[00:17:14.014] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:14.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:97:0) after 1m0s
[00:18:14.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:97:0)
[00:18:14.013] Timer tick, asking Buildbucket for the build status
[00:18:14.102] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:14.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:98:0) after 1m0s
[00:19:14.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:98:0)
[00:19:14.098] Timer tick, asking Buildbucket for the build status
[00:19:14.245] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:14.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:99:0) after 1m0s
[00:20:14.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:99:0)
[00:20:14.276] Timer tick, asking Buildbucket for the build status
[00:20:14.316] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:14.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:100:0) after 1m0s
[00:21:14.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:100:0)
[00:21:14.313] Timer tick, asking Buildbucket for the build status
[00:21:14.401] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:14.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:101:0) after 1m0s
[00:22:14.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:101:0)
[00:22:14.382] Timer tick, asking Buildbucket for the build status
[00:22:14.418] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:14.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:102:0) after 1m0s
[00:23:14.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:102:0)
[00:23:14.392] Timer tick, asking Buildbucket for the build status
[00:23:14.467] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:14.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:103:0) after 1m0s
[00:24:14.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:103:0)
[00:24:14.475] Timer tick, asking Buildbucket for the build status
[00:24:14.521] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:14.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:104:0) after 1m0s
[00:25:14.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:104:0)
[00:25:14.544] Timer tick, asking Buildbucket for the build status
[00:25:14.697] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:14.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:105:0) after 1m0s
[00:26:14.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:105:0)
[00:26:14.693] Timer tick, asking Buildbucket for the build status
[00:26:14.736] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:14.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:106:0) after 1m0s
[00:27:14.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:106:0)
[00:27:14.716] Timer tick, asking Buildbucket for the build status
[00:27:14.785] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:14.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:107:0) after 1m0s
[00:28:14.772] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:107:0)
[00:28:14.772] Timer tick, asking Buildbucket for the build status
[00:28:16.730] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:16.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:108:0) after 1m0s
[00:29:16.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:108:0)
[00:29:16.719] Timer tick, asking Buildbucket for the build status
[00:29:16.779] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:16.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:109:0) after 1m0s
[00:30:16.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:109:0)
[00:30:16.803] Timer tick, asking Buildbucket for the build status
[00:30:16.981] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:16.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:110:0) after 1m0s
[00:31:17.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:110:0)
[00:31:17.003] Timer tick, asking Buildbucket for the build status
[00:31:17.047] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:17.047] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:111:0) after 1m0s
[00:32:17.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:111:0)
[00:32:17.066] Timer tick, asking Buildbucket for the build status
[00:32:17.108] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:17.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:112:0) after 1m0s
[00:33:17.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:112:0)
[00:33:17.124] Timer tick, asking Buildbucket for the build status
[00:33:17.219] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:17.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:113:0) after 1m0s
[00:34:17.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:113:0)
[00:34:17.221] Timer tick, asking Buildbucket for the build status
[00:34:17.287] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:17.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:114:0) after 1m0s
[00:35:17.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:114:0)
[00:35:17.293] Timer tick, asking Buildbucket for the build status
[00:35:17.332] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:17.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:115:0) after 1m0s
[00:36:17.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:115:0)
[00:36:17.354] Timer tick, asking Buildbucket for the build status
[00:36:17.480] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:17.480] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:116:0) after 1m0s
[00:37:17.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:116:0)
[00:37:17.484] Timer tick, asking Buildbucket for the build status
[00:37:17.611] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:17.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:117:0) after 1m0s
[00:38:17.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:117:0)
[00:38:17.671] Timer tick, asking Buildbucket for the build status
[00:38:17.760] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:17.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:118:0) after 1m0s
[00:39:17.799] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:118:0)
[00:39:17.799] Timer tick, asking Buildbucket for the build status
[00:39:17.901] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:17.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:119:0) after 1m0s
[00:40:17.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:119:0)
[00:40:17.922] Timer tick, asking Buildbucket for the build status
[00:40:17.995] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:17.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:120:0) after 1m0s
[00:41:17.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:120:0)
[00:41:17.998] Timer tick, asking Buildbucket for the build status
[00:41:18.034] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:18.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:121:0) after 1m0s
[00:42:18.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:121:0)
[00:42:18.062] Timer tick, asking Buildbucket for the build status
[00:42:18.118] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:18.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:122:0) after 1m0s
[00:43:18.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:122:0)
[00:43:18.143] Timer tick, asking Buildbucket for the build status
[00:43:18.260] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:18.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:123:0) after 1m0s
[00:44:18.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:123:0)
[00:44:18.238] Timer tick, asking Buildbucket for the build status
[00:44:18.273] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:18.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:124:0) after 1m0s
[00:45:18.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:124:0)
[00:45:18.317] Timer tick, asking Buildbucket for the build status
[00:45:18.363] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:18.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:125:0) after 1m0s
[00:46:18.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:125:0)
[00:46:18.390] Timer tick, asking Buildbucket for the build status
[00:46:18.423] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:18.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:126:0) after 1m0s
[00:47:18.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:126:0)
[00:47:18.462] Timer tick, asking Buildbucket for the build status
[00:47:18.520] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:18.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:127:0) after 1m0s
[00:48:18.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:127:0)
[00:48:18.506] Timer tick, asking Buildbucket for the build status
[00:48:18.539] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:18.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:128:0) after 1m0s
[00:49:18.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:128:0)
[00:49:18.562] Timer tick, asking Buildbucket for the build status
[00:49:18.632] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:18.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:129:0) after 1m0s
[00:50:18.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:129:0)
[00:50:18.655] Timer tick, asking Buildbucket for the build status
[00:50:18.967] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:18.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:130:0) after 1m0s
[00:51:18.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:130:0)
[00:51:18.997] Timer tick, asking Buildbucket for the build status
[00:51:19.073] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:19.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:131:0) after 1m0s
[00:52:19.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:131:0)
[00:52:19.093] Timer tick, asking Buildbucket for the build status
[00:52:19.169] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:19.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:132:0) after 1m0s
[00:53:19.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:132:0)
[00:53:19.213] Timer tick, asking Buildbucket for the build status
[00:53:19.257] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:19.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:133:0) after 1m0s
[00:54:19.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:133:0)
[00:54:19.278] Timer tick, asking Buildbucket for the build status
[00:54:19.373] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:19.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:134:0) after 1m0s
[00:55:19.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:134:0)
[00:55:19.408] Timer tick, asking Buildbucket for the build status
[00:55:19.505] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:19.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:135:0) after 1m0s
[00:56:19.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:135:0)
[00:56:19.528] Timer tick, asking Buildbucket for the build status
[00:56:19.576] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:19.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:136:0) after 1m0s
[00:57:19.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:136:0)
[00:57:19.599] Timer tick, asking Buildbucket for the build status
[00:57:19.635] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:19.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:137:0) after 1m0s
[00:58:19.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:137:0)
[00:58:19.658] Timer tick, asking Buildbucket for the build status
[00:58:19.738] Build 8919061667901801200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:19.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084491731414553232:138:0) after 1m0s
[00:58:46.474] Received PubSub notification, asking Buildbucket for the build status
[00:58:46.600] Build 8919061667901801200: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:58:46.600] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "AUTO",
"completed_ts": "1552525125218492",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552516983086578",
"id": "8919061667901801200",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"74.0.3729.6\"}}",
"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\": [\"build-from-tarball-0-xq1d\"], \"server_version\": [\"4186-af94c3f\"], \"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.3729.6\", \"path_config\": \"generic\", \"bot_id\": \"build-from-tarball-0-xq1d\"}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1552517037510760",
"status": "COMPLETED",
"status_changed_ts": "1552525126078719",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9084491731414553232",
"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/8919061667901801200/+/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:43920ab24e4d3810",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1552525126082411",
"url": "https://ci.chromium.org/b/8919061667901801200",
"utcnow_ts": "1552525126579208"
}
}
[00:58:46.600] Invocation finished in 2h15m46.247307141s with status SUCCEEDED