[18:20:24.138] New invocation is queued and will start shortly
[18:20:24.138] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[18:20:25.171] Starting the invocation (attempt 1)
[18:20:25.205] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:20:25.205] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:20:25.206] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9084961237853259952",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"74.0.3726.4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9084961237853259952",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[18:20:27.095] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552069225283309",
"id": "8919531175987681792",
"lease_expiration_ts": "1552188026586470",
"lease_key": "1202956225",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"74.0.3726.4\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1552069226595467",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9084961237853259952",
"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/8919531175987681792/+/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:43775a7658dfc210",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1552069226596906",
"url": "https://ci.chromium.org/b/8919531175987681792",
"utcnow_ts": "1552069227056039"
}
}
[18:20:27.095] Task URL: https://ci.chromium.org/b/8919531175987681792
[18:20:27.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:2:0) after 1m0s
[18:21:21.337] Received PubSub notification, asking Buildbucket for the build status
[18:21:21.435] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:27.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:2:0)
[18:21:27.155] Timer tick, asking Buildbucket for the build status
[18:21:27.264] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:27.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:4:0) after 1m0s
[18:22:27.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:4:0)
[18:22:27.295] Timer tick, asking Buildbucket for the build status
[18:22:27.515] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:27.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:5:0) after 1m0s
[18:23:27.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:5:0)
[18:23:27.532] Timer tick, asking Buildbucket for the build status
[18:23:27.765] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:27.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:6:0) after 1m0s
[18:24:27.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:6:0)
[18:24:27.810] Timer tick, asking Buildbucket for the build status
[18:24:27.899] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:27.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:7:0) after 1m0s
[18:25:27.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:7:0)
[18:25:27.883] Timer tick, asking Buildbucket for the build status
[18:25:27.943] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:27.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:8:0) after 1m0s
[18:26:27.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:8:0)
[18:26:27.999] Timer tick, asking Buildbucket for the build status
[18:26:28.064] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:28.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:9:0) after 1m0s
[18:27:28.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:9:0)
[18:27:28.089] Timer tick, asking Buildbucket for the build status
[18:27:28.157] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:28.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:10:0) after 1m0s
[18:28:28.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:10:0)
[18:28:28.175] Timer tick, asking Buildbucket for the build status
[18:28:28.292] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:28.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:11:0) after 1m0s
[18:29:28.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:11:0)
[18:29:28.297] Timer tick, asking Buildbucket for the build status
[18:29:28.403] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:28.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:12:0) after 1m0s
[18:30:28.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:12:0)
[18:30:28.381] Timer tick, asking Buildbucket for the build status
[18:30:28.420] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:28.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:13:0) after 1m0s
[18:31:28.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:13:0)
[18:31:28.441] Timer tick, asking Buildbucket for the build status
[18:31:28.609] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:28.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:14:0) after 1m0s
[18:32:28.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:14:0)
[18:32:28.588] Timer tick, asking Buildbucket for the build status
[18:32:28.635] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:28.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:15:0) after 1m0s
[18:33:28.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:15:0)
[18:33:28.642] Timer tick, asking Buildbucket for the build status
[18:33:28.762] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:28.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:16:0) after 1m0s
[18:34:28.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:16:0)
[18:34:28.768] Timer tick, asking Buildbucket for the build status
[18:34:28.810] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:28.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:17:0) after 1m0s
[18:35:28.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:17:0)
[18:35:28.829] Timer tick, asking Buildbucket for the build status
[18:35:28.865] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:28.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:18:0) after 1m0s
[18:36:28.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:18:0)
[18:36:28.893] Timer tick, asking Buildbucket for the build status
[18:36:28.970] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:28.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:19:0) after 1m0s
[18:37:28.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:19:0)
[18:37:28.971] Timer tick, asking Buildbucket for the build status
[18:37:29.044] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:29.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:20:0) after 1m0s
[18:38:29.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:20:0)
[18:38:29.064] Timer tick, asking Buildbucket for the build status
[18:38:29.111] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:29.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:21:0) after 1m0s
[18:39:29.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:21:0)
[18:39:29.132] Timer tick, asking Buildbucket for the build status
[18:39:29.199] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:29.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:22:0) after 1m0s
[18:40:29.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:22:0)
[18:40:29.211] Timer tick, asking Buildbucket for the build status
[18:40:29.290] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:29.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:23:0) after 1m0s
[18:41:29.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:23:0)
[18:41:29.311] Timer tick, asking Buildbucket for the build status
[18:41:29.482] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:29.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:24:0) after 1m0s
[18:42:29.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:24:0)
[18:42:29.476] Timer tick, asking Buildbucket for the build status
[18:42:29.728] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:29.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:25:0) after 1m0s
[18:43:29.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:25:0)
[18:43:29.720] Timer tick, asking Buildbucket for the build status
[18:43:29.866] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:29.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:26:0) after 1m0s
[18:44:29.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:26:0)
[18:44:29.889] Timer tick, asking Buildbucket for the build status
[18:44:29.992] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:29.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:27:0) after 1m0s
[18:45:30.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:27:0)
[18:45:30.014] Timer tick, asking Buildbucket for the build status
[18:45:30.119] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:30.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:28:0) after 1m0s
[18:46:30.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:28:0)
[18:46:30.156] Timer tick, asking Buildbucket for the build status
[18:46:30.192] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:30.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:29:0) after 1m0s
[18:47:30.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:29:0)
[18:47:30.167] Timer tick, asking Buildbucket for the build status
[18:47:30.273] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:30.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:30:0) after 1m0s
[18:48:30.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:30:0)
[18:48:30.295] Timer tick, asking Buildbucket for the build status
[18:48:30.333] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:30.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:31:0) after 1m0s
[18:49:30.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:31:0)
[18:49:30.314] Timer tick, asking Buildbucket for the build status
[18:49:30.348] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:30.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:32:0) after 1m0s
[18:50:30.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:32:0)
[18:50:30.369] Timer tick, asking Buildbucket for the build status
[18:50:30.495] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:30.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:33:0) after 1m0s
[18:51:30.509] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:33:0)
[18:51:30.509] Timer tick, asking Buildbucket for the build status
[18:51:30.542] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:30.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:34:0) after 1m0s
[18:52:30.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:34:0)
[18:52:30.565] Timer tick, asking Buildbucket for the build status
[18:52:30.629] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:30.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:35:0) after 1m0s
[18:53:30.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:35:0)
[18:53:30.646] Timer tick, asking Buildbucket for the build status
[18:53:30.754] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:30.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:36:0) after 1m0s
[18:54:30.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:36:0)
[18:54:30.763] Timer tick, asking Buildbucket for the build status
[18:54:30.809] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:30.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:37:0) after 1m0s
[18:55:30.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:37:0)
[18:55:30.782] Timer tick, asking Buildbucket for the build status
[18:55:30.837] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:30.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:38:0) after 1m0s
[18:56:30.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:38:0)
[18:56:30.838] Timer tick, asking Buildbucket for the build status
[18:56:30.880] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:30.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:39:0) after 1m0s
[18:57:30.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:39:0)
[18:57:30.894] Timer tick, asking Buildbucket for the build status
[18:57:31.009] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:31.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:40:0) after 1m0s
[18:58:31.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:40:0)
[18:58:31.022] Timer tick, asking Buildbucket for the build status
[18:58:31.168] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:31.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:41:0) after 1m0s
[18:59:31.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:41:0)
[18:59:31.178] Timer tick, asking Buildbucket for the build status
[18:59:31.313] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:31.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:42:0) after 1m0s
[19:00:31.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:42:0)
[19:00:31.315] Timer tick, asking Buildbucket for the build status
[19:00:31.353] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:31.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:43:0) after 1m0s
[19:01:31.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:43:0)
[19:01:31.378] Timer tick, asking Buildbucket for the build status
[19:01:31.413] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:31.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:44:0) after 1m0s
[19:02:31.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:44:0)
[19:02:31.435] Timer tick, asking Buildbucket for the build status
[19:02:31.476] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:31.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:45:0) after 1m0s
[19:03:31.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:45:0)
[19:03:31.496] Timer tick, asking Buildbucket for the build status
[19:03:31.532] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:31.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:46:0) after 1m0s
[19:04:31.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:46:0)
[19:04:31.551] Timer tick, asking Buildbucket for the build status
[19:04:31.591] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:31.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:47:0) after 1m0s
[19:05:31.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:47:0)
[19:05:31.591] Timer tick, asking Buildbucket for the build status
[19:05:31.652] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:31.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:48:0) after 1m0s
[19:06:31.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:48:0)
[19:06:31.677] Timer tick, asking Buildbucket for the build status
[19:06:31.725] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:31.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:49:0) after 1m0s
[19:07:31.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:49:0)
[19:07:31.744] Timer tick, asking Buildbucket for the build status
[19:07:31.783] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:31.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:50:0) after 1m0s
[19:08:31.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:50:0)
[19:08:31.802] Timer tick, asking Buildbucket for the build status
[19:08:31.842] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:31.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:51:0) after 1m0s
[19:09:31.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:51:0)
[19:09:31.861] Timer tick, asking Buildbucket for the build status
[19:09:31.896] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:31.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:52:0) after 1m0s
[19:10:31.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:52:0)
[19:10:31.921] Timer tick, asking Buildbucket for the build status
[19:10:32.000] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:32.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:53:0) after 1m0s
[19:11:32.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:53:0)
[19:11:32.016] Timer tick, asking Buildbucket for the build status
[19:11:32.065] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:32.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:54:0) after 1m0s
[19:12:32.090] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:54:0)
[19:12:32.090] Timer tick, asking Buildbucket for the build status
[19:12:32.182] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:32.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:55:0) after 1m0s
[19:13:32.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:55:0)
[19:13:32.165] Timer tick, asking Buildbucket for the build status
[19:13:32.234] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:32.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:56:0) after 1m0s
[19:14:32.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:56:0)
[19:14:32.285] Timer tick, asking Buildbucket for the build status
[19:14:32.376] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:32.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:57:0) after 1m0s
[19:15:32.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:57:0)
[19:15:32.390] Timer tick, asking Buildbucket for the build status
[19:15:32.509] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:32.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:58:0) after 1m0s
[19:16:32.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:58:0)
[19:16:32.523] Timer tick, asking Buildbucket for the build status
[19:16:32.574] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:32.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:59:0) after 1m0s
[19:17:32.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:59:0)
[19:17:32.611] Timer tick, asking Buildbucket for the build status
[19:17:32.697] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:32.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:60:0) after 1m0s
[19:18:32.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:60:0)
[19:18:32.704] Timer tick, asking Buildbucket for the build status
[19:18:32.744] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:32.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:61:0) after 1m0s
[19:19:32.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:61:0)
[19:19:32.766] Timer tick, asking Buildbucket for the build status
[19:19:32.802] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:32.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:62:0) after 1m0s
[19:20:32.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:62:0)
[19:20:32.817] Timer tick, asking Buildbucket for the build status
[19:20:32.882] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:32.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:63:0) after 1m0s
[19:21:32.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:63:0)
[19:21:32.902] Timer tick, asking Buildbucket for the build status
[19:21:32.939] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:32.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:64:0) after 1m0s
[19:22:32.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:64:0)
[19:22:32.929] Timer tick, asking Buildbucket for the build status
[19:22:32.963] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:32.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:65:0) after 1m0s
[19:23:32.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:65:0)
[19:23:32.987] Timer tick, asking Buildbucket for the build status
[19:23:33.163] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:33.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:66:0) after 1m0s
[19:24:33.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:66:0)
[19:24:33.179] Timer tick, asking Buildbucket for the build status
[19:24:33.296] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:33.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:67:0) after 1m0s
[19:25:33.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:67:0)
[19:25:33.329] Timer tick, asking Buildbucket for the build status
[19:25:33.410] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:33.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:68:0) after 1m0s
[19:26:33.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:68:0)
[19:26:33.445] Timer tick, asking Buildbucket for the build status
[19:26:33.629] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:33.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:69:0) after 1m0s
[19:27:33.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:69:0)
[19:27:33.653] Timer tick, asking Buildbucket for the build status
[19:27:33.698] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:33.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:70:0) after 1m0s
[19:28:33.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:70:0)
[19:28:33.677] Timer tick, asking Buildbucket for the build status
[19:28:33.776] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:33.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:71:0) after 1m0s
[19:29:33.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:71:0)
[19:29:33.755] Timer tick, asking Buildbucket for the build status
[19:29:33.822] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:33.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:72:0) after 1m0s
[19:30:33.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:72:0)
[19:30:33.839] Timer tick, asking Buildbucket for the build status
[19:30:33.880] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:33.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:73:0) after 1m0s
[19:31:33.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:73:0)
[19:31:33.904] Timer tick, asking Buildbucket for the build status
[19:31:33.944] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:33.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:74:0) after 1m0s
[19:32:33.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:74:0)
[19:32:33.917] Timer tick, asking Buildbucket for the build status
[19:32:33.960] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:33.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:75:0) after 1m0s
[19:33:33.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:75:0)
[19:33:33.982] Timer tick, asking Buildbucket for the build status
[19:33:34.023] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:34.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:76:0) after 1m0s
[19:34:34.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:76:0)
[19:34:34.047] Timer tick, asking Buildbucket for the build status
[19:34:34.155] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:34.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:77:0) after 1m0s
[19:35:34.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:77:0)
[19:35:34.160] Timer tick, asking Buildbucket for the build status
[19:35:34.197] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:34.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:78:0) after 1m0s
[19:36:34.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:78:0)
[19:36:34.196] Timer tick, asking Buildbucket for the build status
[19:36:34.253] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:34.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:79:0) after 1m0s
[19:37:34.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:79:0)
[19:37:34.276] Timer tick, asking Buildbucket for the build status
[19:37:34.317] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:34.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:80:0) after 1m0s
[19:38:34.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:80:0)
[19:38:34.294] Timer tick, asking Buildbucket for the build status
[19:38:34.377] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:34.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:81:0) after 1m0s
[19:39:34.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:81:0)
[19:39:34.417] Timer tick, asking Buildbucket for the build status
[19:39:34.455] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:34.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:82:0) after 1m0s
[19:40:34.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:82:0)
[19:40:34.475] Timer tick, asking Buildbucket for the build status
[19:40:34.594] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:34.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:83:0) after 1m0s
[19:41:34.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:83:0)
[19:41:34.608] Timer tick, asking Buildbucket for the build status
[19:41:34.647] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:34.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:84:0) after 1m0s
[19:42:34.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:84:0)
[19:42:34.698] Timer tick, asking Buildbucket for the build status
[19:42:34.849] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:34.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:85:0) after 1m0s
[19:43:34.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:85:0)
[19:43:34.893] Timer tick, asking Buildbucket for the build status
[19:43:34.950] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:34.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:86:0) after 1m0s
[19:44:34.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:86:0)
[19:44:34.945] Timer tick, asking Buildbucket for the build status
[19:44:34.991] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:34.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:87:0) after 1m0s
[19:45:35.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:87:0)
[19:45:35.013] Timer tick, asking Buildbucket for the build status
[19:45:35.046] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:35.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:88:0) after 1m0s
[19:46:35.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:88:0)
[19:46:35.029] Timer tick, asking Buildbucket for the build status
[19:46:35.161] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:35.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:89:0) after 1m0s
[19:47:35.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:89:0)
[19:47:35.183] Timer tick, asking Buildbucket for the build status
[19:47:35.219] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:35.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:90:0) after 1m0s
[19:48:35.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:90:0)
[19:48:35.193] Timer tick, asking Buildbucket for the build status
[19:48:35.237] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:35.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:91:0) after 1m0s
[19:49:35.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:91:0)
[19:49:35.259] Timer tick, asking Buildbucket for the build status
[19:49:35.403] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:35.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:92:0) after 1m0s
[19:50:35.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:92:0)
[19:50:35.429] Timer tick, asking Buildbucket for the build status
[19:50:35.524] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:35.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:93:0) after 1m0s
[19:51:35.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:93:0)
[19:51:35.546] Timer tick, asking Buildbucket for the build status
[19:51:35.585] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:35.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:94:0) after 1m0s
[19:52:35.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:94:0)
[19:52:35.594] Timer tick, asking Buildbucket for the build status
[19:52:35.630] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:35.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:95:0) after 1m0s
[19:53:35.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:95:0)
[19:53:35.652] Timer tick, asking Buildbucket for the build status
[19:53:35.704] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:35.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:96:0) after 1m0s
[19:54:35.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:96:0)
[19:54:35.716] Timer tick, asking Buildbucket for the build status
[19:54:35.782] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:35.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:97:0) after 1m0s
[19:55:35.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:97:0)
[19:55:35.786] Timer tick, asking Buildbucket for the build status
[19:55:35.822] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:35.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:98:0) after 1m0s
[19:56:35.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:98:0)
[19:56:35.805] Timer tick, asking Buildbucket for the build status
[19:56:35.916] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:35.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:99:0) after 1m0s
[19:57:35.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:99:0)
[19:57:35.937] Timer tick, asking Buildbucket for the build status
[19:57:35.978] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:35.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:100:0) after 1m0s
[19:58:35.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:100:0)
[19:58:35.986] Timer tick, asking Buildbucket for the build status
[19:58:36.027] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:36.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:101:0) after 1m0s
[19:59:36.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:101:0)
[19:59:36.052] Timer tick, asking Buildbucket for the build status
[19:59:36.109] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:36.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:102:0) after 1m0s
[20:00:36.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:102:0)
[20:00:36.117] Timer tick, asking Buildbucket for the build status
[20:00:36.458] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:36.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:103:0) after 1m0s
[20:01:36.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:103:0)
[20:01:36.474] Timer tick, asking Buildbucket for the build status
[20:01:36.574] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:36.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:104:0) after 1m0s
[20:02:36.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:104:0)
[20:02:36.545] Timer tick, asking Buildbucket for the build status
[20:02:36.583] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:36.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:105:0) after 1m0s
[20:03:36.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:105:0)
[20:03:36.599] Timer tick, asking Buildbucket for the build status
[20:03:36.641] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:36.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:106:0) after 1m0s
[20:04:36.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:106:0)
[20:04:36.661] Timer tick, asking Buildbucket for the build status
[20:04:36.720] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:36.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:107:0) after 1m0s
[20:05:36.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:107:0)
[20:05:36.729] Timer tick, asking Buildbucket for the build status
[20:05:36.804] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:36.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:108:0) after 1m0s
[20:06:36.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:108:0)
[20:06:36.801] Timer tick, asking Buildbucket for the build status
[20:06:36.839] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:36.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:109:0) after 1m0s
[20:07:36.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:109:0)
[20:07:36.898] Timer tick, asking Buildbucket for the build status
[20:07:37.060] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:37.060] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:110:0) after 1m0s
[20:08:37.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:110:0)
[20:08:37.073] Timer tick, asking Buildbucket for the build status
[20:08:37.123] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:37.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:111:0) after 1m0s
[20:09:37.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:111:0)
[20:09:37.195] Timer tick, asking Buildbucket for the build status
[20:09:37.296] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:37.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:112:0) after 1m0s
[20:10:37.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:112:0)
[20:10:37.287] Timer tick, asking Buildbucket for the build status
[20:10:37.317] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:37.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:113:0) after 1m0s
[20:11:37.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:113:0)
[20:11:37.340] Timer tick, asking Buildbucket for the build status
[20:11:37.451] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:37.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:114:0) after 1m0s
[20:12:37.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:114:0)
[20:12:37.476] Timer tick, asking Buildbucket for the build status
[20:12:37.524] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:37.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:115:0) after 1m0s
[20:13:37.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:115:0)
[20:13:37.527] Timer tick, asking Buildbucket for the build status
[20:13:37.570] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:37.570] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:116:0) after 1m0s
[20:14:37.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:116:0)
[20:14:37.580] Timer tick, asking Buildbucket for the build status
[20:14:37.634] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:37.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:117:0) after 1m0s
[20:15:37.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:117:0)
[20:15:37.627] Timer tick, asking Buildbucket for the build status
[20:15:37.667] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:37.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:118:0) after 1m0s
[20:16:37.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:118:0)
[20:16:37.668] Timer tick, asking Buildbucket for the build status
[20:16:37.700] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:37.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:119:0) after 1m0s
[20:17:37.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:119:0)
[20:17:37.681] Timer tick, asking Buildbucket for the build status
[20:17:37.747] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:37.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:120:0) after 1m0s
[20:18:37.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:120:0)
[20:18:37.770] Timer tick, asking Buildbucket for the build status
[20:18:37.810] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:37.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:121:0) after 1m0s
[20:19:37.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:121:0)
[20:19:37.846] Timer tick, asking Buildbucket for the build status
[20:19:38.046] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:38.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:122:0) after 1m0s
[20:20:38.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:122:0)
[20:20:38.070] Timer tick, asking Buildbucket for the build status
[20:20:38.159] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:38.160] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:123:0) after 1m0s
[20:21:38.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:123:0)
[20:21:38.187] Timer tick, asking Buildbucket for the build status
[20:21:38.241] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:38.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:124:0) after 1m0s
[20:22:38.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:124:0)
[20:22:38.257] Timer tick, asking Buildbucket for the build status
[20:22:38.309] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:38.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:125:0) after 1m0s
[20:23:38.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:125:0)
[20:23:38.328] Timer tick, asking Buildbucket for the build status
[20:23:38.380] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:38.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:126:0) after 1m0s
[20:24:38.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:126:0)
[20:24:38.375] Timer tick, asking Buildbucket for the build status
[20:24:38.415] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:38.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:127:0) after 1m0s
[20:25:38.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:127:0)
[20:25:38.435] Timer tick, asking Buildbucket for the build status
[20:25:38.479] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:38.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:128:0) after 1m0s
[20:26:38.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:128:0)
[20:26:38.469] Timer tick, asking Buildbucket for the build status
[20:26:38.515] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:38.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:129:0) after 1m0s
[20:27:38.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:129:0)
[20:27:38.502] Timer tick, asking Buildbucket for the build status
[20:27:38.637] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:38.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:130:0) after 1m0s
[20:28:38.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:130:0)
[20:28:38.655] Timer tick, asking Buildbucket for the build status
[20:28:38.775] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:38.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:131:0) after 1m0s
[20:29:38.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:131:0)
[20:29:38.778] Timer tick, asking Buildbucket for the build status
[20:29:38.921] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:38.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:132:0) after 1m0s
[20:30:38.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:132:0)
[20:30:38.946] Timer tick, asking Buildbucket for the build status
[20:30:39.099] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:39.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:133:0) after 1m0s
[20:31:39.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:133:0)
[20:31:39.085] Timer tick, asking Buildbucket for the build status
[20:31:39.345] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:39.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:134:0) after 1m0s
[20:32:39.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:134:0)
[20:32:39.336] Timer tick, asking Buildbucket for the build status
[20:32:39.375] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:39.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:135:0) after 1m0s
[20:33:39.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:135:0)
[20:33:39.397] Timer tick, asking Buildbucket for the build status
[20:33:39.499] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:39.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:136:0) after 1m0s
[20:34:39.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:136:0)
[20:34:39.515] Timer tick, asking Buildbucket for the build status
[20:34:39.644] Build 8919531175987681792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:39.644] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9084961237853259952:137:0) after 1m0s
[20:35:02.417] Received PubSub notification, asking Buildbucket for the build status
[20:35:02.462] Build 8919531175987681792: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:35:02.462] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "AUTO",
"completed_ts": "1552077301357439",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552069225283309",
"id": "8919531175987681792",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"74.0.3726.4\"}}",
"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-ltts\"], \"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.3726.4\", \"path_config\": \"generic\", \"bot_id\": \"gce-trusty-32-0258d129-us-east1-b-ltts\"}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1552069280494609",
"status": "COMPLETED",
"status_changed_ts": "1552077302100903",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9084961237853259952",
"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/8919531175987681792/+/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:43775a7658dfc210",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1552077302104603",
"url": "https://ci.chromium.org/b/8919531175987681792",
"utcnow_ts": "1552077302454323"
}
}
[20:35:02.462] Invocation finished in 2h14m38.34071131s with status SUCCEEDED