[10:11:00.158] New invocation is queued and will start shortly
[10:11:00.158] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[10:11:01.223] Starting the invocation (attempt 1)
[10:11:01.316] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:11:01.316] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:11:01.316] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9085263819118203232",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"74.0.3724.5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9085263819118203232",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[10:11:03.000] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary": true,
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551780661408332",
"id": "8919833757142207024",
"lease_expiration_ts": "1551899462479237",
"lease_key": "833186970",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"74.0.3724.5\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1551780662485544",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9085263819118203232",
"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/8919833757142207024/+/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:4366275331b98010",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1551780662485677",
"url": "https://ci.chromium.org/b/8919833757142207024",
"utcnow_ts": "1551780662980302"
}
}
[10:11:03.000] Task URL: https://ci.chromium.org/b/8919833757142207024
[10:11:03.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:2:0) after 1m0s
[10:11:34.570] Received PubSub notification, asking Buildbucket for the build status
[10:11:34.611] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:02.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:2:0)
[10:12:02.988] Timer tick, asking Buildbucket for the build status
[10:12:03.066] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:03.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:4:0) after 1m0s
[10:13:03.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:4:0)
[10:13:03.079] Timer tick, asking Buildbucket for the build status
[10:13:03.526] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:03.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:5:0) after 1m0s
[10:14:03.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:5:0)
[10:14:03.547] Timer tick, asking Buildbucket for the build status
[10:14:03.764] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:03.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:6:0) after 1m0s
[10:15:03.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:6:0)
[10:15:03.778] Timer tick, asking Buildbucket for the build status
[10:15:03.897] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:03.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:7:0) after 1m0s
[10:16:03.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:7:0)
[10:16:03.897] Timer tick, asking Buildbucket for the build status
[10:16:04.227] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:04.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:8:0) after 1m0s
[10:17:04.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:8:0)
[10:17:04.245] Timer tick, asking Buildbucket for the build status
[10:17:04.403] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:04.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:9:0) after 1m0s
[10:18:04.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:9:0)
[10:18:04.419] Timer tick, asking Buildbucket for the build status
[10:18:04.460] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:04.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:10:0) after 1m0s
[10:19:04.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:10:0)
[10:19:04.477] Timer tick, asking Buildbucket for the build status
[10:19:04.517] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:04.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:11:0) after 1m0s
[10:20:04.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:11:0)
[10:20:04.528] Timer tick, asking Buildbucket for the build status
[10:20:04.583] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:04.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:12:0) after 1m0s
[10:21:04.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:12:0)
[10:21:04.595] Timer tick, asking Buildbucket for the build status
[10:21:04.668] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:04.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:13:0) after 1m0s
[10:22:04.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:13:0)
[10:22:04.680] Timer tick, asking Buildbucket for the build status
[10:22:04.722] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:04.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:14:0) after 1m0s
[10:23:04.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:14:0)
[10:23:04.752] Timer tick, asking Buildbucket for the build status
[10:23:04.873] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:04.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:15:0) after 1m0s
[10:24:04.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:15:0)
[10:24:04.863] Timer tick, asking Buildbucket for the build status
[10:24:04.912] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:04.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:16:0) after 1m0s
[10:25:04.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:16:0)
[10:25:04.923] Timer tick, asking Buildbucket for the build status
[10:25:04.960] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:04.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:17:0) after 1m0s
[10:26:04.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:17:0)
[10:26:04.977] Timer tick, asking Buildbucket for the build status
[10:26:05.060] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:05.060] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:18:0) after 1m0s
[10:27:05.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:18:0)
[10:27:05.078] Timer tick, asking Buildbucket for the build status
[10:27:05.151] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:05.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:19:0) after 1m0s
[10:28:05.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:19:0)
[10:28:05.123] Timer tick, asking Buildbucket for the build status
[10:28:05.161] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:05.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:20:0) after 1m0s
[10:29:05.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:20:0)
[10:29:05.162] Timer tick, asking Buildbucket for the build status
[10:29:05.239] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:05.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:21:0) after 1m0s
[10:30:05.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:21:0)
[10:30:05.337] Timer tick, asking Buildbucket for the build status
[10:30:05.722] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:05.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:22:0) after 1m0s
[10:31:05.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:22:0)
[10:31:05.705] Timer tick, asking Buildbucket for the build status
[10:31:05.792] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:05.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:23:0) after 1m0s
[10:32:05.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:23:0)
[10:32:05.805] Timer tick, asking Buildbucket for the build status
[10:32:05.920] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:05.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:24:0) after 1m0s
[10:33:05.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:24:0)
[10:33:05.949] Timer tick, asking Buildbucket for the build status
[10:33:05.997] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:05.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:25:0) after 1m0s
[10:34:06.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:25:0)
[10:34:06.026] Timer tick, asking Buildbucket for the build status
[10:34:06.199] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:06.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:26:0) after 1m0s
[10:35:06.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:26:0)
[10:35:06.219] Timer tick, asking Buildbucket for the build status
[10:35:06.263] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:06.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:27:0) after 1m0s
[10:36:06.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:27:0)
[10:36:06.258] Timer tick, asking Buildbucket for the build status
[10:36:06.402] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:06.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:28:0) after 1m0s
[10:37:06.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:28:0)
[10:37:06.445] Timer tick, asking Buildbucket for the build status
[10:37:06.589] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:06.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:29:0) after 1m0s
[10:38:06.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:29:0)
[10:38:06.595] Timer tick, asking Buildbucket for the build status
[10:38:06.664] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:06.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:30:0) after 1m0s
[10:39:06.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:30:0)
[10:39:06.686] Timer tick, asking Buildbucket for the build status
[10:39:06.821] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:06.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:31:0) after 1m0s
[10:40:06.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:31:0)
[10:40:06.836] Timer tick, asking Buildbucket for the build status
[10:40:06.903] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:06.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:32:0) after 1m0s
[10:41:06.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:32:0)
[10:41:06.929] Timer tick, asking Buildbucket for the build status
[10:41:06.991] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:06.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:33:0) after 1m0s
[10:42:07.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:33:0)
[10:42:07.009] Timer tick, asking Buildbucket for the build status
[10:42:07.099] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:07.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:34:0) after 1m0s
[10:43:07.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:34:0)
[10:43:07.153] Timer tick, asking Buildbucket for the build status
[10:43:07.207] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:07.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:35:0) after 1m0s
[10:44:07.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:35:0)
[10:44:07.206] Timer tick, asking Buildbucket for the build status
[10:44:07.246] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:07.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:36:0) after 1m0s
[10:45:07.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:36:0)
[10:45:07.275] Timer tick, asking Buildbucket for the build status
[10:45:07.386] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:07.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:37:0) after 1m0s
[10:46:07.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:37:0)
[10:46:07.409] Timer tick, asking Buildbucket for the build status
[10:46:07.562] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:07.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:38:0) after 1m0s
[10:47:07.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:38:0)
[10:47:07.586] Timer tick, asking Buildbucket for the build status
[10:47:07.664] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:07.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:39:0) after 1m0s
[10:48:07.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:39:0)
[10:48:07.678] Timer tick, asking Buildbucket for the build status
[10:48:07.725] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:07.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:40:0) after 1m0s
[10:49:07.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:40:0)
[10:49:07.698] Timer tick, asking Buildbucket for the build status
[10:49:07.757] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:07.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:41:0) after 1m0s
[10:50:07.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:41:0)
[10:50:07.786] Timer tick, asking Buildbucket for the build status
[10:50:07.840] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:07.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:42:0) after 1m0s
[10:51:07.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:42:0)
[10:51:07.838] Timer tick, asking Buildbucket for the build status
[10:51:07.897] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:07.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:43:0) after 1m0s
[10:52:07.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:43:0)
[10:52:07.899] Timer tick, asking Buildbucket for the build status
[10:52:07.977] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:07.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:44:0) after 1m0s
[10:53:07.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:44:0)
[10:53:07.951] Timer tick, asking Buildbucket for the build status
[10:53:08.084] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:08.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:45:0) after 1m0s
[10:54:08.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:45:0)
[10:54:08.079] Timer tick, asking Buildbucket for the build status
[10:54:08.137] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:08.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:46:0) after 1m0s
[10:55:08.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:46:0)
[10:55:08.158] Timer tick, asking Buildbucket for the build status
[10:55:08.199] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:08.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:47:0) after 1m0s
[10:56:08.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:47:0)
[10:56:08.227] Timer tick, asking Buildbucket for the build status
[10:56:08.319] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:08.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:48:0) after 1m0s
[10:57:08.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:48:0)
[10:57:08.402] Timer tick, asking Buildbucket for the build status
[10:57:08.489] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:08.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:49:0) after 1m0s
[10:58:08.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:49:0)
[10:58:08.481] Timer tick, asking Buildbucket for the build status
[10:58:08.520] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:08.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:50:0) after 1m0s
[10:59:08.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:50:0)
[10:59:08.487] Timer tick, asking Buildbucket for the build status
[10:59:08.552] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:08.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:51:0) after 1m0s
[11:00:08.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:51:0)
[11:00:08.569] Timer tick, asking Buildbucket for the build status
[11:00:08.627] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:08.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:52:0) after 1m0s
[11:01:08.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:52:0)
[11:01:08.604] Timer tick, asking Buildbucket for the build status
[11:01:08.643] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:08.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:53:0) after 1m0s
[11:02:08.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:53:0)
[11:02:08.640] Timer tick, asking Buildbucket for the build status
[11:02:08.711] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:08.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:54:0) after 1m0s
[11:03:08.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:54:0)
[11:03:08.734] Timer tick, asking Buildbucket for the build status
[11:03:08.769] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:08.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:55:0) after 1m0s
[11:04:08.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:55:0)
[11:04:08.789] Timer tick, asking Buildbucket for the build status
[11:04:08.903] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:08.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:56:0) after 1m0s
[11:05:08.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:56:0)
[11:05:08.920] Timer tick, asking Buildbucket for the build status
[11:05:08.980] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:08.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:57:0) after 1m0s
[11:06:08.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:57:0)
[11:06:08.998] Timer tick, asking Buildbucket for the build status
[11:06:09.086] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:09.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:58:0) after 1m0s
[11:07:09.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:58:0)
[11:07:09.101] Timer tick, asking Buildbucket for the build status
[11:07:09.146] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:09.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:59:0) after 1m0s
[11:08:09.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:59:0)
[11:08:09.164] Timer tick, asking Buildbucket for the build status
[11:08:09.321] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:09.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:60:0) after 1m0s
[11:09:09.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:60:0)
[11:09:09.341] Timer tick, asking Buildbucket for the build status
[11:09:09.447] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:09.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:61:0) after 1m0s
[11:10:09.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:61:0)
[11:10:09.489] Timer tick, asking Buildbucket for the build status
[11:10:10.025] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:10.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:62:0) after 1m0s
[11:11:10.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:62:0)
[11:11:10.055] Timer tick, asking Buildbucket for the build status
[11:11:10.100] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:10.100] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:63:0) after 1m0s
[11:12:10.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:63:0)
[11:12:10.128] Timer tick, asking Buildbucket for the build status
[11:12:10.210] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:10.210] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:64:0) after 1m0s
[11:13:10.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:64:0)
[11:13:10.234] Timer tick, asking Buildbucket for the build status
[11:13:10.407] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:10.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:65:0) after 1m0s
[11:14:10.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:65:0)
[11:14:10.432] Timer tick, asking Buildbucket for the build status
[11:14:10.526] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:10.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:66:0) after 1m0s
[11:15:10.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:66:0)
[11:15:10.550] Timer tick, asking Buildbucket for the build status
[11:15:10.592] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:10.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:67:0) after 1m0s
[11:16:10.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:67:0)
[11:16:10.603] Timer tick, asking Buildbucket for the build status
[11:16:10.672] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:10.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:68:0) after 1m0s
[11:17:10.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:68:0)
[11:17:10.645] Timer tick, asking Buildbucket for the build status
[11:17:10.705] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:10.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:69:0) after 1m0s
[11:18:10.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:69:0)
[11:18:10.724] Timer tick, asking Buildbucket for the build status
[11:18:10.820] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:10.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:70:0) after 1m0s
[11:19:10.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:70:0)
[11:19:10.842] Timer tick, asking Buildbucket for the build status
[11:19:10.968] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:10.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:71:0) after 1m0s
[11:20:11.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:71:0)
[11:20:11.006] Timer tick, asking Buildbucket for the build status
[11:20:11.064] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:11.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:72:0) after 1m0s
[11:21:11.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:72:0)
[11:21:11.054] Timer tick, asking Buildbucket for the build status
[11:21:11.102] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:11.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:73:0) after 1m0s
[11:22:11.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:73:0)
[11:22:11.123] Timer tick, asking Buildbucket for the build status
[11:22:11.211] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:11.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:74:0) after 1m0s
[11:23:11.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:74:0)
[11:23:11.237] Timer tick, asking Buildbucket for the build status
[11:23:11.316] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:11.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:75:0) after 1m0s
[11:24:11.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:75:0)
[11:24:11.343] Timer tick, asking Buildbucket for the build status
[11:24:11.402] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:11.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:76:0) after 1m0s
[11:25:11.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:76:0)
[11:25:11.424] Timer tick, asking Buildbucket for the build status
[11:25:11.469] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:11.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:77:0) after 1m0s
[11:26:11.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:77:0)
[11:26:11.489] Timer tick, asking Buildbucket for the build status
[11:26:11.676] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:11.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:78:0) after 1m0s
[11:27:11.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:78:0)
[11:27:11.683] Timer tick, asking Buildbucket for the build status
[11:27:11.733] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:11.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:79:0) after 1m0s
[11:28:11.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:79:0)
[11:28:11.730] Timer tick, asking Buildbucket for the build status
[11:28:11.798] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:11.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:80:0) after 1m0s
[11:29:11.826] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:80:0)
[11:29:11.826] Timer tick, asking Buildbucket for the build status
[11:29:11.862] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:11.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:81:0) after 1m0s
[11:30:11.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:81:0)
[11:30:11.877] Timer tick, asking Buildbucket for the build status
[11:30:11.939] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:11.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:82:0) after 1m0s
[11:31:11.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:82:0)
[11:31:11.937] Timer tick, asking Buildbucket for the build status
[11:31:11.981] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:11.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:83:0) after 1m0s
[11:32:11.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:83:0)
[11:32:11.991] Timer tick, asking Buildbucket for the build status
[11:32:12.074] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:12.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:84:0) after 1m0s
[11:33:12.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:84:0)
[11:33:12.089] Timer tick, asking Buildbucket for the build status
[11:33:12.130] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:12.130] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:85:0) after 1m0s
[11:34:12.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:85:0)
[11:34:12.118] Timer tick, asking Buildbucket for the build status
[11:34:12.303] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:12.303] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:86:0) after 1m0s
[11:35:12.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:86:0)
[11:35:12.329] Timer tick, asking Buildbucket for the build status
[11:35:12.387] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:12.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:87:0) after 1m0s
[11:36:12.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:87:0)
[11:36:12.419] Timer tick, asking Buildbucket for the build status
[11:36:12.604] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:12.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:88:0) after 1m0s
[11:37:12.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:88:0)
[11:37:12.621] Timer tick, asking Buildbucket for the build status
[11:37:12.661] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:12.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:89:0) after 1m0s
[11:38:12.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:89:0)
[11:38:12.684] Timer tick, asking Buildbucket for the build status
[11:38:12.763] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:12.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:90:0) after 1m0s
[11:39:12.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:90:0)
[11:39:12.801] Timer tick, asking Buildbucket for the build status
[11:39:12.856] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:12.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:91:0) after 1m0s
[11:40:12.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:91:0)
[11:40:12.837] Timer tick, asking Buildbucket for the build status
[11:40:12.895] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:12.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:92:0) after 1m0s
[11:41:12.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:92:0)
[11:41:12.878] Timer tick, asking Buildbucket for the build status
[11:41:12.921] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:12.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:93:0) after 1m0s
[11:42:12.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:93:0)
[11:42:12.914] Timer tick, asking Buildbucket for the build status
[11:42:13.000] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:13.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:94:0) after 1m0s
[11:43:13.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:94:0)
[11:43:13.002] Timer tick, asking Buildbucket for the build status
[11:43:13.046] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:13.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:95:0) after 1m0s
[11:44:13.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:95:0)
[11:44:13.029] Timer tick, asking Buildbucket for the build status
[11:44:13.229] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:13.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:96:0) after 1m0s
[11:45:13.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:96:0)
[11:45:13.256] Timer tick, asking Buildbucket for the build status
[11:45:13.342] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:13.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:97:0) after 1m0s
[11:46:13.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:97:0)
[11:46:13.393] Timer tick, asking Buildbucket for the build status
[11:46:13.447] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:13.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:98:0) after 1m0s
[11:47:13.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:98:0)
[11:47:13.467] Timer tick, asking Buildbucket for the build status
[11:47:13.517] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:13.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:99:0) after 1m0s
[11:48:13.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:99:0)
[11:48:13.537] Timer tick, asking Buildbucket for the build status
[11:48:13.603] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:13.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:100:0) after 1m0s
[11:49:13.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:100:0)
[11:49:13.614] Timer tick, asking Buildbucket for the build status
[11:49:13.647] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:13.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:101:0) after 1m0s
[11:50:13.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:101:0)
[11:50:13.652] Timer tick, asking Buildbucket for the build status
[11:50:13.722] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:13.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:102:0) after 1m0s
[11:51:13.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:102:0)
[11:51:13.742] Timer tick, asking Buildbucket for the build status
[11:51:13.776] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:13.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:103:0) after 1m0s
[11:52:13.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:103:0)
[11:52:13.803] Timer tick, asking Buildbucket for the build status
[11:52:13.833] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:13.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:104:0) after 1m0s
[11:53:13.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:104:0)
[11:53:13.853] Timer tick, asking Buildbucket for the build status
[11:53:13.989] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:13.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:105:0) after 1m0s
[11:54:13.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:105:0)
[11:54:13.969] Timer tick, asking Buildbucket for the build status
[11:54:14.024] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:14.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:106:0) after 1m0s
[11:55:14.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:106:0)
[11:55:14.065] Timer tick, asking Buildbucket for the build status
[11:55:14.213] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:14.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:107:0) after 1m0s
[11:56:14.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:107:0)
[11:56:14.240] Timer tick, asking Buildbucket for the build status
[11:56:14.390] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:14.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:108:0) after 1m0s
[11:57:14.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:108:0)
[11:57:14.500] Timer tick, asking Buildbucket for the build status
[11:57:14.532] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:14.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:109:0) after 1m0s
[11:58:14.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:109:0)
[11:58:14.554] Timer tick, asking Buildbucket for the build status
[11:58:14.615] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:14.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:110:0) after 1m0s
[11:59:14.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:110:0)
[11:59:14.615] Timer tick, asking Buildbucket for the build status
[11:59:14.769] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:14.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:111:0) after 1m0s
[12:00:14.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:111:0)
[12:00:14.794] Timer tick, asking Buildbucket for the build status
[12:00:14.854] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:14.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:112:0) after 1m0s
[12:01:14.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:112:0)
[12:01:14.881] Timer tick, asking Buildbucket for the build status
[12:01:14.928] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:14.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:113:0) after 1m0s
[12:02:15.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:113:0)
[12:02:15.151] Timer tick, asking Buildbucket for the build status
[12:02:15.249] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:15.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:114:0) after 1m0s
[12:03:15.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:114:0)
[12:03:15.284] Timer tick, asking Buildbucket for the build status
[12:03:15.316] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:15.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:115:0) after 1m0s
[12:04:15.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:115:0)
[12:04:15.364] Timer tick, asking Buildbucket for the build status
[12:04:15.414] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:15.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:116:0) after 1m0s
[12:05:15.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:116:0)
[12:05:15.439] Timer tick, asking Buildbucket for the build status
[12:05:15.804] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:15.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:117:0) after 1m0s
[12:06:15.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:117:0)
[12:06:15.825] Timer tick, asking Buildbucket for the build status
[12:06:16.121] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:16.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:118:0) after 1m0s
[12:07:16.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:118:0)
[12:07:16.101] Timer tick, asking Buildbucket for the build status
[12:07:16.220] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:16.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:119:0) after 1m0s
[12:08:16.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:119:0)
[12:08:16.228] Timer tick, asking Buildbucket for the build status
[12:08:16.356] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:16.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:120:0) after 1m0s
[12:09:16.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:120:0)
[12:09:16.379] Timer tick, asking Buildbucket for the build status
[12:09:16.487] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:16.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:121:0) after 1m0s
[12:10:16.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:121:0)
[12:10:16.494] Timer tick, asking Buildbucket for the build status
[12:10:16.534] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:16.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:122:0) after 1m0s
[12:11:16.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:122:0)
[12:11:16.560] Timer tick, asking Buildbucket for the build status
[12:11:16.620] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:16.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:123:0) after 1m0s
[12:12:16.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:123:0)
[12:12:16.664] Timer tick, asking Buildbucket for the build status
[12:12:16.875] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:16.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:124:0) after 1m0s
[12:13:16.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:124:0)
[12:13:16.896] Timer tick, asking Buildbucket for the build status
[12:13:16.985] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:16.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:125:0) after 1m0s
[12:14:17.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:125:0)
[12:14:17.008] Timer tick, asking Buildbucket for the build status
[12:14:17.193] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:17.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:126:0) after 1m0s
[12:15:17.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:126:0)
[12:15:17.219] Timer tick, asking Buildbucket for the build status
[12:15:17.637] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:17.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:127:0) after 1m0s
[12:16:17.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:127:0)
[12:16:17.621] Timer tick, asking Buildbucket for the build status
[12:16:17.661] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:17.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:128:0) after 1m0s
[12:17:17.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:128:0)
[12:17:17.658] Timer tick, asking Buildbucket for the build status
[12:17:17.733] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:17.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:129:0) after 1m0s
[12:18:17.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:129:0)
[12:18:17.712] Timer tick, asking Buildbucket for the build status
[12:18:17.925] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:17.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:130:0) after 1m0s
[12:19:17.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:130:0)
[12:19:17.948] Timer tick, asking Buildbucket for the build status
[12:19:18.054] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:18.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:131:0) after 1m0s
[12:20:18.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:131:0)
[12:20:18.089] Timer tick, asking Buildbucket for the build status
[12:20:18.186] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:18.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:132:0) after 1m0s
[12:21:18.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:132:0)
[12:21:18.208] Timer tick, asking Buildbucket for the build status
[12:21:18.246] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:18.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:133:0) after 1m0s
[12:22:18.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:133:0)
[12:22:18.227] Timer tick, asking Buildbucket for the build status
[12:22:18.283] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:18.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:134:0) after 1m0s
[12:23:18.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:134:0)
[12:23:18.302] Timer tick, asking Buildbucket for the build status
[12:23:18.422] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:18.422] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:135:0) after 1m0s
[12:24:18.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:135:0)
[12:24:18.452] Timer tick, asking Buildbucket for the build status
[12:24:18.503] Build 8919833757142207024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:18.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085263819118203232:136:0) after 1m0s
[12:24:57.486] Received PubSub notification, asking Buildbucket for the build status
[12:24:57.519] Build 8919833757142207024: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:24:57.519] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1551788696476112",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551780661408332",
"id": "8919833757142207024",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"74.0.3724.5\"}}",
"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-qkrt\"], \"server_version\": [\"4143-92e279d\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"gpu\": [\"none\"], \"cores\": [\"32\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"pool\": [\"luci.infra.cron\"], \"caches\": [\"vpython\"]}}, \"ui\": {\"info\": \"\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"buildername\": \"Build From Tarball\", \"recipe\": \"build_from_tarball\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"version\": \"74.0.3724.5\", \"path_config\": \"generic\", \"bot_id\": \"gce-trusty-32-0258d129-us-east1-b-qkrt\"}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1551780693888930",
"status": "COMPLETED",
"status_changed_ts": "1551788697202375",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9085263819118203232",
"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/8919833757142207024/+/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:4366275331b98010",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1551788697203656",
"url": "https://ci.chromium.org/b/8919833757142207024",
"utcnow_ts": "1551788697511015"
}
}
[12:24:57.519] Invocation finished in 2h13m57.378492853s with status SUCCEEDED