[10:37:36.305] New invocation is queued and will start shortly
[10:37:36.305] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[10:37:37.396] Starting the invocation (attempt 1)
[10:37:37.432] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:37:37.432] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:37:37.432] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9084899757569236064",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"74.0.3729.2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9084899757569236064",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[10:37:38.314] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552127857548321",
"id": "8919469695601480592",
"lease_expiration_ts": "1552246658097304",
"lease_key": "971330885",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"74.0.3729.2\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1552127858098542",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9084899757569236064",
"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/8919469695601480592/+/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:437ad91c72d7e310",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1552127858098643",
"url": "https://ci.chromium.org/b/8919469695601480592",
"utcnow_ts": "1552127858303428"
}
}
[10:37:38.314] Task URL: https://ci.chromium.org/b/8919469695601480592
[10:37:38.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:2:0) after 1m0s
[10:37:51.478] Received PubSub notification, asking Buildbucket for the build status
[10:37:51.574] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:38.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:2:0)
[10:38:38.285] Timer tick, asking Buildbucket for the build status
[10:38:38.346] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:38.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:4:0) after 1m0s
[10:39:38.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:4:0)
[10:39:38.404] Timer tick, asking Buildbucket for the build status
[10:39:38.501] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:38.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:5:0) after 1m0s
[10:40:38.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:5:0)
[10:40:38.520] Timer tick, asking Buildbucket for the build status
[10:40:38.601] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:38.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:6:0) after 1m0s
[10:41:38.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:6:0)
[10:41:38.618] Timer tick, asking Buildbucket for the build status
[10:41:38.676] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:38.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:7:0) after 1m0s
[10:42:38.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:7:0)
[10:42:38.693] Timer tick, asking Buildbucket for the build status
[10:42:38.755] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:38.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:8:0) after 1m0s
[10:43:38.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:8:0)
[10:43:38.773] Timer tick, asking Buildbucket for the build status
[10:43:38.840] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:38.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:9:0) after 1m0s
[10:44:38.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:9:0)
[10:44:38.831] Timer tick, asking Buildbucket for the build status
[10:44:39.385] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:39.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:10:0) after 1m0s
[10:45:39.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:10:0)
[10:45:39.392] Timer tick, asking Buildbucket for the build status
[10:45:39.500] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:39.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:11:0) after 1m0s
[10:46:39.509] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:11:0)
[10:46:39.510] Timer tick, asking Buildbucket for the build status
[10:46:39.592] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:39.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:12:0) after 1m0s
[10:47:39.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:12:0)
[10:47:39.632] Timer tick, asking Buildbucket for the build status
[10:47:39.711] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:39.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:13:0) after 1m0s
[10:48:39.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:13:0)
[10:48:39.693] Timer tick, asking Buildbucket for the build status
[10:48:39.904] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:39.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:14:0) after 1m0s
[10:49:39.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:14:0)
[10:49:39.904] Timer tick, asking Buildbucket for the build status
[10:49:39.961] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:39.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:15:0) after 1m0s
[10:50:39.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:15:0)
[10:50:39.985] Timer tick, asking Buildbucket for the build status
[10:50:40.044] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:40.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:16:0) after 1m0s
[10:51:40.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:16:0)
[10:51:40.063] Timer tick, asking Buildbucket for the build status
[10:51:40.099] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:40.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:17:0) after 1m0s
[10:52:40.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:17:0)
[10:52:40.112] Timer tick, asking Buildbucket for the build status
[10:52:40.168] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:40.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:18:0) after 1m0s
[10:53:40.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:18:0)
[10:53:40.190] Timer tick, asking Buildbucket for the build status
[10:53:40.451] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:40.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:19:0) after 1m0s
[10:54:40.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:19:0)
[10:54:40.486] Timer tick, asking Buildbucket for the build status
[10:54:40.595] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:40.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:20:0) after 1m0s
[10:55:40.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:20:0)
[10:55:40.614] Timer tick, asking Buildbucket for the build status
[10:55:40.724] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:40.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:21:0) after 1m0s
[10:56:40.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:21:0)
[10:56:40.743] Timer tick, asking Buildbucket for the build status
[10:56:40.802] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:40.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:22:0) after 1m0s
[10:57:40.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:22:0)
[10:57:40.778] Timer tick, asking Buildbucket for the build status
[10:57:40.891] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:40.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:23:0) after 1m0s
[10:58:40.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:23:0)
[10:58:40.910] Timer tick, asking Buildbucket for the build status
[10:58:40.987] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:40.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:24:0) after 1m0s
[10:59:41.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:24:0)
[10:59:41.002] Timer tick, asking Buildbucket for the build status
[10:59:41.055] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:41.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:25:0) after 1m0s
[11:00:41.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:25:0)
[11:00:41.074] Timer tick, asking Buildbucket for the build status
[11:00:41.135] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:41.135] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:26:0) after 1m0s
[11:01:41.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:26:0)
[11:01:41.159] Timer tick, asking Buildbucket for the build status
[11:01:41.200] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:41.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:27:0) after 1m0s
[11:02:41.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:27:0)
[11:02:41.221] Timer tick, asking Buildbucket for the build status
[11:02:41.284] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:41.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:28:0) after 1m0s
[11:03:41.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:28:0)
[11:03:41.303] Timer tick, asking Buildbucket for the build status
[11:03:41.499] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:41.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:29:0) after 1m0s
[11:04:41.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:29:0)
[11:04:41.521] Timer tick, asking Buildbucket for the build status
[11:04:41.588] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:41.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:30:0) after 1m0s
[11:05:41.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:30:0)
[11:05:41.599] Timer tick, asking Buildbucket for the build status
[11:05:41.654] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:41.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:31:0) after 1m0s
[11:06:41.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:31:0)
[11:06:41.672] Timer tick, asking Buildbucket for the build status
[11:06:41.769] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:41.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:32:0) after 1m0s
[11:07:41.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:32:0)
[11:07:41.758] Timer tick, asking Buildbucket for the build status
[11:07:41.815] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:41.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:33:0) after 1m0s
[11:08:41.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:33:0)
[11:08:41.835] Timer tick, asking Buildbucket for the build status
[11:08:41.892] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:41.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:34:0) after 1m0s
[11:09:41.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:34:0)
[11:09:41.885] Timer tick, asking Buildbucket for the build status
[11:09:42.185] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:42.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:35:0) after 1m0s
[11:10:42.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:35:0)
[11:10:42.189] Timer tick, asking Buildbucket for the build status
[11:10:42.243] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:42.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:36:0) after 1m0s
[11:11:42.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:36:0)
[11:11:42.265] Timer tick, asking Buildbucket for the build status
[11:11:42.312] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:42.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:37:0) after 1m0s
[11:12:42.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:37:0)
[11:12:42.325] Timer tick, asking Buildbucket for the build status
[11:12:42.386] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:42.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:38:0) after 1m0s
[11:13:42.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:38:0)
[11:13:42.424] Timer tick, asking Buildbucket for the build status
[11:13:42.518] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:42.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:39:0) after 1m0s
[11:14:42.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:39:0)
[11:14:42.539] Timer tick, asking Buildbucket for the build status
[11:14:42.602] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:42.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:40:0) after 1m0s
[11:15:42.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:40:0)
[11:15:42.633] Timer tick, asking Buildbucket for the build status
[11:15:42.792] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:42.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:41:0) after 1m0s
[11:16:42.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:41:0)
[11:16:42.768] Timer tick, asking Buildbucket for the build status
[11:16:42.836] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:42.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:42:0) after 1m0s
[11:17:42.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:42:0)
[11:17:42.842] Timer tick, asking Buildbucket for the build status
[11:17:42.898] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:42.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:43:0) after 1m0s
[11:18:42.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:43:0)
[11:18:42.912] Timer tick, asking Buildbucket for the build status
[11:18:43.008] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:43.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:44:0) after 1m0s
[11:19:42.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:44:0)
[11:19:42.995] Timer tick, asking Buildbucket for the build status
[11:19:43.033] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:43.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:45:0) after 1m0s
[11:20:43.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:45:0)
[11:20:43.065] Timer tick, asking Buildbucket for the build status
[11:20:43.193] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:43.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:46:0) after 1m0s
[11:21:43.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:46:0)
[11:21:43.217] Timer tick, asking Buildbucket for the build status
[11:21:43.258] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:43.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:47:0) after 1m0s
[11:22:43.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:47:0)
[11:22:43.276] Timer tick, asking Buildbucket for the build status
[11:22:43.407] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:43.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:48:0) after 1m0s
[11:23:43.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:48:0)
[11:23:43.406] Timer tick, asking Buildbucket for the build status
[11:23:43.589] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:43.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:49:0) after 1m0s
[11:24:43.598] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:49:0)
[11:24:43.598] Timer tick, asking Buildbucket for the build status
[11:24:43.690] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:43.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:50:0) after 1m0s
[11:25:43.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:50:0)
[11:25:43.677] Timer tick, asking Buildbucket for the build status
[11:25:43.731] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:43.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:51:0) after 1m0s
[11:26:43.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:51:0)
[11:26:43.751] Timer tick, asking Buildbucket for the build status
[11:26:43.788] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:43.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:52:0) after 1m0s
[11:27:43.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:52:0)
[11:27:43.777] Timer tick, asking Buildbucket for the build status
[11:27:43.946] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:43.946] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:53:0) after 1m0s
[11:28:43.926] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:53:0)
[11:28:43.926] Timer tick, asking Buildbucket for the build status
[11:28:43.962] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:43.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:54:0) after 1m0s
[11:29:43.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:54:0)
[11:29:43.981] Timer tick, asking Buildbucket for the build status
[11:29:44.034] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:44.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:55:0) after 1m0s
[11:30:44.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:55:0)
[11:30:44.068] Timer tick, asking Buildbucket for the build status
[11:30:44.268] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:44.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:56:0) after 1m0s
[11:31:44.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:56:0)
[11:31:44.253] Timer tick, asking Buildbucket for the build status
[11:31:44.527] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:44.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:57:0) after 1m0s
[11:32:44.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:57:0)
[11:32:44.550] Timer tick, asking Buildbucket for the build status
[11:32:44.605] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:44.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:58:0) after 1m0s
[11:33:44.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:58:0)
[11:33:44.584] Timer tick, asking Buildbucket for the build status
[11:33:44.633] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:44.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:59:0) after 1m0s
[11:34:44.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:59:0)
[11:34:44.651] Timer tick, asking Buildbucket for the build status
[11:34:44.727] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:44.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:60:0) after 1m0s
[11:35:44.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:60:0)
[11:35:44.728] Timer tick, asking Buildbucket for the build status
[11:35:44.782] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:44.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:61:0) after 1m0s
[11:36:44.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:61:0)
[11:36:44.801] Timer tick, asking Buildbucket for the build status
[11:36:44.921] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:44.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:62:0) after 1m0s
[11:37:44.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:62:0)
[11:37:44.940] Timer tick, asking Buildbucket for the build status
[11:37:45.083] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:45.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:63:0) after 1m0s
[11:38:45.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:63:0)
[11:38:45.103] Timer tick, asking Buildbucket for the build status
[11:38:45.179] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:45.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:64:0) after 1m0s
[11:39:45.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:64:0)
[11:39:45.194] Timer tick, asking Buildbucket for the build status
[11:39:45.264] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:45.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:65:0) after 1m0s
[11:40:45.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:65:0)
[11:40:45.283] Timer tick, asking Buildbucket for the build status
[11:40:45.409] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:45.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:66:0) after 1m0s
[11:41:45.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:66:0)
[11:41:45.433] Timer tick, asking Buildbucket for the build status
[11:41:45.530] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:45.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:67:0) after 1m0s
[11:42:45.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:67:0)
[11:42:45.511] Timer tick, asking Buildbucket for the build status
[11:42:45.578] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:45.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:68:0) after 1m0s
[11:43:45.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:68:0)
[11:43:45.584] Timer tick, asking Buildbucket for the build status
[11:43:45.649] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:45.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:69:0) after 1m0s
[11:44:45.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:69:0)
[11:44:45.647] Timer tick, asking Buildbucket for the build status
[11:44:45.706] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:45.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:70:0) after 1m0s
[11:45:45.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:70:0)
[11:45:45.693] Timer tick, asking Buildbucket for the build status
[11:45:45.755] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:45.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:71:0) after 1m0s
[11:46:45.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:71:0)
[11:46:45.757] Timer tick, asking Buildbucket for the build status
[11:46:45.835] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:45.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:72:0) after 1m0s
[11:47:45.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:72:0)
[11:47:45.858] Timer tick, asking Buildbucket for the build status
[11:47:45.918] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:45.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:73:0) after 1m0s
[11:48:45.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:73:0)
[11:48:45.998] Timer tick, asking Buildbucket for the build status
[11:48:46.049] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:46.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:74:0) after 1m0s
[11:49:46.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:74:0)
[11:49:46.027] Timer tick, asking Buildbucket for the build status
[11:49:46.088] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:46.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:75:0) after 1m0s
[11:50:46.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:75:0)
[11:50:46.115] Timer tick, asking Buildbucket for the build status
[11:50:46.373] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:46.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:76:0) after 1m0s
[11:51:46.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:76:0)
[11:51:46.392] Timer tick, asking Buildbucket for the build status
[11:51:46.571] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:46.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:77:0) after 1m0s
[11:52:46.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:77:0)
[11:52:46.592] Timer tick, asking Buildbucket for the build status
[11:52:46.879] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:46.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:78:0) after 1m0s
[11:53:46.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:78:0)
[11:53:46.899] Timer tick, asking Buildbucket for the build status
[11:53:46.960] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:46.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:79:0) after 1m0s
[11:54:46.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:79:0)
[11:54:46.957] Timer tick, asking Buildbucket for the build status
[11:54:47.093] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:47.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:80:0) after 1m0s
[11:55:47.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:80:0)
[11:55:47.076] Timer tick, asking Buildbucket for the build status
[11:55:47.188] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:47.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:81:0) after 1m0s
[11:56:47.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:81:0)
[11:56:47.211] Timer tick, asking Buildbucket for the build status
[11:56:47.271] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:47.271] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:82:0) after 1m0s
[11:57:47.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:82:0)
[11:57:47.294] Timer tick, asking Buildbucket for the build status
[11:57:47.360] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:47.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:83:0) after 1m0s
[11:58:47.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:83:0)
[11:58:47.405] Timer tick, asking Buildbucket for the build status
[11:58:47.585] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:47.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:84:0) after 1m0s
[11:59:47.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:84:0)
[11:59:47.592] Timer tick, asking Buildbucket for the build status
[11:59:47.655] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:47.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:85:0) after 1m0s
[12:00:47.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:85:0)
[12:00:47.633] Timer tick, asking Buildbucket for the build status
[12:00:47.738] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:47.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:86:0) after 1m0s
[12:01:47.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:86:0)
[12:01:47.759] Timer tick, asking Buildbucket for the build status
[12:01:47.816] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:47.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:87:0) after 1m0s
[12:02:47.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:87:0)
[12:02:47.841] Timer tick, asking Buildbucket for the build status
[12:02:47.906] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:47.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:88:0) after 1m0s
[12:03:47.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:88:0)
[12:03:47.886] Timer tick, asking Buildbucket for the build status
[12:03:48.021] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:48.021] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:89:0) after 1m0s
[12:04:48.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:89:0)
[12:04:48.059] Timer tick, asking Buildbucket for the build status
[12:04:48.201] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:48.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:90:0) after 1m0s
[12:05:48.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:90:0)
[12:05:48.211] Timer tick, asking Buildbucket for the build status
[12:05:48.298] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:48.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:91:0) after 1m0s
[12:06:48.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:91:0)
[12:06:48.296] Timer tick, asking Buildbucket for the build status
[12:06:48.368] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:48.368] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:92:0) after 1m0s
[12:07:48.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:92:0)
[12:07:48.370] Timer tick, asking Buildbucket for the build status
[12:07:48.856] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:48.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:93:0) after 1m0s
[12:08:48.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:93:0)
[12:08:48.899] Timer tick, asking Buildbucket for the build status
[12:08:48.956] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:48.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:94:0) after 1m0s
[12:09:48.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:94:0)
[12:09:48.953] Timer tick, asking Buildbucket for the build status
[12:09:49.012] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:49.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:95:0) after 1m0s
[12:10:49.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:95:0)
[12:10:49.161] Timer tick, asking Buildbucket for the build status
[12:10:49.308] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:49.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:96:0) after 1m0s
[12:11:49.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:96:0)
[12:11:49.299] Timer tick, asking Buildbucket for the build status
[12:11:49.461] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:49.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:97:0) after 1m0s
[12:12:49.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:97:0)
[12:12:49.477] Timer tick, asking Buildbucket for the build status
[12:12:49.595] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:49.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:98:0) after 1m0s
[12:13:49.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:98:0)
[12:13:49.616] Timer tick, asking Buildbucket for the build status
[12:13:49.787] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:49.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:99:0) after 1m0s
[12:14:49.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:99:0)
[12:14:49.807] Timer tick, asking Buildbucket for the build status
[12:14:49.879] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:49.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:100:0) after 1m0s
[12:15:49.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:100:0)
[12:15:49.854] Timer tick, asking Buildbucket for the build status
[12:15:49.919] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:49.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:101:0) after 1m0s
[12:16:49.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:101:0)
[12:16:49.944] Timer tick, asking Buildbucket for the build status
[12:16:50.061] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:50.061] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:102:0) after 1m0s
[12:17:50.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:102:0)
[12:17:50.049] Timer tick, asking Buildbucket for the build status
[12:17:50.158] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:50.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:103:0) after 1m0s
[12:18:50.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:103:0)
[12:18:50.179] Timer tick, asking Buildbucket for the build status
[12:18:50.392] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:50.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:104:0) after 1m0s
[12:19:50.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:104:0)
[12:19:50.398] Timer tick, asking Buildbucket for the build status
[12:19:50.460] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:50.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:105:0) after 1m0s
[12:20:50.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:105:0)
[12:20:50.484] Timer tick, asking Buildbucket for the build status
[12:20:50.553] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:50.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:106:0) after 1m0s
[12:21:50.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:106:0)
[12:21:50.583] Timer tick, asking Buildbucket for the build status
[12:21:50.682] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:50.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:107:0) after 1m0s
[12:22:50.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:107:0)
[12:22:50.700] Timer tick, asking Buildbucket for the build status
[12:22:50.766] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:50.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:108:0) after 1m0s
[12:23:50.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:108:0)
[12:23:50.786] Timer tick, asking Buildbucket for the build status
[12:23:50.840] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:50.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:109:0) after 1m0s
[12:24:50.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:109:0)
[12:24:50.819] Timer tick, asking Buildbucket for the build status
[12:24:50.880] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:50.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:110:0) after 1m0s
[12:25:50.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:110:0)
[12:25:50.902] Timer tick, asking Buildbucket for the build status
[12:25:50.953] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:50.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:111:0) after 1m0s
[12:26:50.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:111:0)
[12:26:50.977] Timer tick, asking Buildbucket for the build status
[12:26:51.042] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:51.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:112:0) after 1m0s
[12:27:51.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:112:0)
[12:27:51.063] Timer tick, asking Buildbucket for the build status
[12:27:51.203] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:51.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:113:0) after 1m0s
[12:28:51.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:113:0)
[12:28:51.184] Timer tick, asking Buildbucket for the build status
[12:28:51.387] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:51.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:114:0) after 1m0s
[12:29:51.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:114:0)
[12:29:51.362] Timer tick, asking Buildbucket for the build status
[12:29:51.426] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:51.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:115:0) after 1m0s
[12:30:51.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:115:0)
[12:30:51.423] Timer tick, asking Buildbucket for the build status
[12:30:51.504] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:51.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:116:0) after 1m0s
[12:31:51.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:116:0)
[12:31:51.489] Timer tick, asking Buildbucket for the build status
[12:31:51.582] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:51.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:117:0) after 1m0s
[12:32:51.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:117:0)
[12:32:51.592] Timer tick, asking Buildbucket for the build status
[12:32:51.646] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:51.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:118:0) after 1m0s
[12:33:51.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:118:0)
[12:33:51.681] Timer tick, asking Buildbucket for the build status
[12:33:51.742] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:51.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:119:0) after 1m0s
[12:34:51.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:119:0)
[12:34:51.763] Timer tick, asking Buildbucket for the build status
[12:34:51.956] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:51.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:120:0) after 1m0s
[12:35:51.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:120:0)
[12:35:51.979] Timer tick, asking Buildbucket for the build status
[12:35:52.302] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:52.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:121:0) after 1m0s
[12:36:52.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:121:0)
[12:36:52.288] Timer tick, asking Buildbucket for the build status
[12:36:52.349] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:52.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:122:0) after 1m0s
[12:37:52.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:122:0)
[12:37:52.393] Timer tick, asking Buildbucket for the build status
[12:37:52.464] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:52.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:123:0) after 1m0s
[12:38:52.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:123:0)
[12:38:52.499] Timer tick, asking Buildbucket for the build status
[12:38:52.558] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:52.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:124:0) after 1m0s
[12:39:52.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:124:0)
[12:39:52.585] Timer tick, asking Buildbucket for the build status
[12:39:52.717] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:52.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:125:0) after 1m0s
[12:40:52.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:125:0)
[12:40:52.732] Timer tick, asking Buildbucket for the build status
[12:40:52.805] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:52.805] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:126:0) after 1m0s
[12:41:52.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:126:0)
[12:41:52.878] Timer tick, asking Buildbucket for the build status
[12:41:52.965] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:52.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:127:0) after 1m0s
[12:42:52.980] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:127:0)
[12:42:52.980] Timer tick, asking Buildbucket for the build status
[12:42:53.044] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:53.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:128:0) after 1m0s
[12:43:53.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:128:0)
[12:43:53.065] Timer tick, asking Buildbucket for the build status
[12:43:53.198] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:53.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:129:0) after 1m0s
[12:44:53.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:129:0)
[12:44:53.218] Timer tick, asking Buildbucket for the build status
[12:44:53.282] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:53.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:130:0) after 1m0s
[12:45:53.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:130:0)
[12:45:53.272] Timer tick, asking Buildbucket for the build status
[12:45:53.462] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:53.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:131:0) after 1m0s
[12:46:53.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:131:0)
[12:46:53.496] Timer tick, asking Buildbucket for the build status
[12:46:53.557] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:53.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:132:0) after 1m0s
[12:47:53.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:132:0)
[12:47:53.577] Timer tick, asking Buildbucket for the build status
[12:47:53.751] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:53.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:133:0) after 1m0s
[12:48:53.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:133:0)
[12:48:53.768] Timer tick, asking Buildbucket for the build status
[12:48:53.836] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:53.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:134:0) after 1m0s
[12:49:53.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:134:0)
[12:49:53.858] Timer tick, asking Buildbucket for the build status
[12:49:53.920] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:53.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:135:0) after 1m0s
[12:50:53.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:135:0)
[12:50:53.948] Timer tick, asking Buildbucket for the build status
[12:50:54.083] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:54.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:136:0) after 1m0s
[12:51:54.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:136:0)
[12:51:54.111] Timer tick, asking Buildbucket for the build status
[12:51:54.262] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:54.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:137:0) after 1m0s
[12:52:54.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:137:0)
[12:52:54.274] Timer tick, asking Buildbucket for the build status
[12:52:54.389] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:54.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:138:0) after 1m0s
[12:53:54.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:138:0)
[12:53:54.411] Timer tick, asking Buildbucket for the build status
[12:53:54.464] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:54.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:139:0) after 1m0s
[12:54:54.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:139:0)
[12:54:54.498] Timer tick, asking Buildbucket for the build status
[12:54:54.683] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:54.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:140:0) after 1m0s
[12:55:54.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:140:0)
[12:55:54.661] Timer tick, asking Buildbucket for the build status
[12:55:54.722] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:54.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:141:0) after 1m0s
[12:56:54.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:141:0)
[12:56:54.701] Timer tick, asking Buildbucket for the build status
[12:56:54.780] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:54.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:142:0) after 1m0s
[12:57:54.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:142:0)
[12:57:54.800] Timer tick, asking Buildbucket for the build status
[12:57:54.857] Build 8919469695601480592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:54.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084899757569236064:143:0) after 1m0s
[12:58:29.868] Received PubSub notification, asking Buildbucket for the build status
[12:58:29.911] Build 8919469695601480592: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:58:29.911] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "AUTO",
"completed_ts": "1552136309158335",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552127857548321",
"id": "8919469695601480592",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"74.0.3729.2\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"machine_type\": [\"n1-standard-32\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Build From Tarball\"], \"kvm\": [\"1\"], \"id\": [\"gce-trusty-32-0258d129-us-east1-b-sxtq\"], \"server_version\": [\"4158-1053c58\"], \"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.2\", \"path_config\": \"generic\", \"bot_id\": \"gce-trusty-32-0258d129-us-east1-b-sxtq\"}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1552127870921465",
"status": "COMPLETED",
"status_changed_ts": "1552136309628455",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9084899757569236064",
"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/8919469695601480592/+/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:437ad91c72d7e310",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1552136309632481",
"url": "https://ci.chromium.org/b/8919469695601480592",
"utcnow_ts": "1552136309902458"
}
}
[12:58:29.911] Invocation finished in 2h20m53.623183178s with status SUCCEEDED