[11:07:39.168] New invocation is queued and will start shortly
[11:07:39.168] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[11:07:40.378] Starting the invocation (attempt 1)
[11:07:40.418] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:07:40.418] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:07:40.418] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9029543120660787968",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4320.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"5da9138b-29ad-4fb4-8fb5-975d90af4255\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4320.0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9029543120660787968",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[11:07:44.336] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1604920060811499",
"id": "8864113058273619632",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4320.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"5da9138b-29ad-4fb4-8fb5-975d90af4255\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4320.0\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604920063188331",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9029543120660787968",
"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/8864113058273619632/+/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:",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1604920063188415",
"url": "https://ci.chromium.org/b/8864113058273619632",
"utcnow_ts": "1604920064295805"
}
}
[11:07:44.336] Task URL: https://ci.chromium.org/b/8864113058273619632
[11:07:44.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:2:0) after 1m0s
[11:08:36.752] Received PubSub notification, asking Buildbucket for the build status
[11:08:36.873] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:44.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:2:0)
[11:08:44.368] Timer tick, asking Buildbucket for the build status
[11:08:44.460] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:44.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:4:0) after 1m0s
[11:09:44.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:4:0)
[11:09:44.461] Timer tick, asking Buildbucket for the build status
[11:09:44.615] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:44.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:5:0) after 1m0s
[11:10:44.643] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:5:0)
[11:10:44.643] Timer tick, asking Buildbucket for the build status
[11:10:44.713] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:44.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:6:0) after 1m0s
[11:11:44.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:6:0)
[11:11:44.803] Timer tick, asking Buildbucket for the build status
[11:11:44.908] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:44.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:7:0) after 1m0s
[11:12:45.030] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:7:0)
[11:12:45.030] Timer tick, asking Buildbucket for the build status
[11:12:46.348] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:46.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:8:0) after 1m0s
[11:13:46.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:8:0)
[11:13:46.386] Timer tick, asking Buildbucket for the build status
[11:13:46.528] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:46.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:9:0) after 1m0s
[11:14:46.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:9:0)
[11:14:46.561] Timer tick, asking Buildbucket for the build status
[11:14:46.618] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:46.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:10:0) after 1m0s
[11:15:46.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:10:0)
[11:15:46.704] Timer tick, asking Buildbucket for the build status
[11:15:46.867] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:46.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:11:0) after 1m0s
[11:16:46.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:11:0)
[11:16:46.879] Timer tick, asking Buildbucket for the build status
[11:16:46.935] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:46.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:12:0) after 1m0s
[11:17:47.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:12:0)
[11:17:47.077] Timer tick, asking Buildbucket for the build status
[11:17:47.326] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:47.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:13:0) after 1m0s
[11:18:47.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:13:0)
[11:18:47.373] Timer tick, asking Buildbucket for the build status
[11:18:47.448] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:47.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:14:0) after 1m0s
[11:19:47.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:14:0)
[11:19:47.486] Timer tick, asking Buildbucket for the build status
[11:19:47.619] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:47.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:15:0) after 1m0s
[11:20:47.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:15:0)
[11:20:47.759] Timer tick, asking Buildbucket for the build status
[11:20:47.890] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:47.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:16:0) after 1m0s
[11:21:48.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:16:0)
[11:21:48.043] Timer tick, asking Buildbucket for the build status
[11:21:48.113] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:48.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:17:0) after 1m0s
[11:22:48.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:17:0)
[11:22:48.181] Timer tick, asking Buildbucket for the build status
[11:22:48.732] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:48.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:18:0) after 1m0s
[11:23:48.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:18:0)
[11:23:48.902] Timer tick, asking Buildbucket for the build status
[11:23:48.995] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:48.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:19:0) after 1m0s
[11:24:49.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:19:0)
[11:24:49.191] Timer tick, asking Buildbucket for the build status
[11:24:49.289] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:49.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:20:0) after 1m0s
[11:25:49.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:20:0)
[11:25:49.437] Timer tick, asking Buildbucket for the build status
[11:25:49.533] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:49.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:21:0) after 1m0s
[11:26:49.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:21:0)
[11:26:49.617] Timer tick, asking Buildbucket for the build status
[11:26:49.775] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:49.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:22:0) after 1m0s
[11:27:49.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:22:0)
[11:27:49.842] Timer tick, asking Buildbucket for the build status
[11:27:50.128] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:50.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:23:0) after 1m0s
[11:28:50.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:23:0)
[11:28:50.253] Timer tick, asking Buildbucket for the build status
[11:28:50.327] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:50.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:24:0) after 1m0s
[11:29:50.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:24:0)
[11:29:50.410] Timer tick, asking Buildbucket for the build status
[11:29:50.533] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:50.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:25:0) after 1m0s
[11:30:50.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:25:0)
[11:30:50.622] Timer tick, asking Buildbucket for the build status
[11:30:50.706] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:50.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:26:0) after 1m0s
[11:31:50.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:26:0)
[11:31:50.751] Timer tick, asking Buildbucket for the build status
[11:31:50.857] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:50.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:27:0) after 1m0s
[11:32:50.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:27:0)
[11:32:50.927] Timer tick, asking Buildbucket for the build status
[11:32:51.108] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:51.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:28:0) after 1m0s
[11:33:51.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:28:0)
[11:33:51.154] Timer tick, asking Buildbucket for the build status
[11:33:51.220] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:51.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:29:0) after 1m0s
[11:34:51.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:29:0)
[11:34:51.226] Timer tick, asking Buildbucket for the build status
[11:34:51.333] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:51.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:30:0) after 1m0s
[11:35:51.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:30:0)
[11:35:51.402] Timer tick, asking Buildbucket for the build status
[11:35:51.533] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:51.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:31:0) after 1m0s
[11:36:51.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:31:0)
[11:36:51.565] Timer tick, asking Buildbucket for the build status
[11:36:51.677] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:51.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:32:0) after 1m0s
[11:37:51.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:32:0)
[11:37:51.749] Timer tick, asking Buildbucket for the build status
[11:37:51.870] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:51.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:33:0) after 1m0s
[11:38:51.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:33:0)
[11:38:51.904] Timer tick, asking Buildbucket for the build status
[11:38:52.023] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:52.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:34:0) after 1m0s
[11:39:52.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:34:0)
[11:39:52.097] Timer tick, asking Buildbucket for the build status
[11:39:52.155] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:52.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:35:0) after 1m0s
[11:40:52.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:35:0)
[11:40:52.208] Timer tick, asking Buildbucket for the build status
[11:40:52.322] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:52.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:36:0) after 1m0s
[11:41:52.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:36:0)
[11:41:52.403] Timer tick, asking Buildbucket for the build status
[11:41:52.464] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:52.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:37:0) after 1m0s
[11:42:52.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:37:0)
[11:42:52.554] Timer tick, asking Buildbucket for the build status
[11:42:52.701] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:52.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:38:0) after 1m0s
[11:43:52.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:38:0)
[11:43:52.836] Timer tick, asking Buildbucket for the build status
[11:43:52.895] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:52.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:39:0) after 1m0s
[11:44:53.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:39:0)
[11:44:53.069] Timer tick, asking Buildbucket for the build status
[11:44:53.141] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:53.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:40:0) after 1m0s
[11:45:53.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:40:0)
[11:45:53.248] Timer tick, asking Buildbucket for the build status
[11:45:53.332] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:53.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:41:0) after 1m0s
[11:46:53.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:41:0)
[11:46:53.421] Timer tick, asking Buildbucket for the build status
[11:46:53.486] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:53.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:42:0) after 1m0s
[11:47:53.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:42:0)
[11:47:53.683] Timer tick, asking Buildbucket for the build status
[11:47:53.864] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:53.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:43:0) after 1m0s
[11:48:53.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:43:0)
[11:48:53.916] Timer tick, asking Buildbucket for the build status
[11:48:54.000] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:54.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:44:0) after 1m0s
[11:49:54.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:44:0)
[11:49:54.057] Timer tick, asking Buildbucket for the build status
[11:49:54.119] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:54.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:45:0) after 1m0s
[11:50:54.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:45:0)
[11:50:54.159] Timer tick, asking Buildbucket for the build status
[11:50:54.244] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:54.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:46:0) after 1m0s
[11:51:54.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:46:0)
[11:51:54.315] Timer tick, asking Buildbucket for the build status
[11:51:54.372] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:54.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:47:0) after 1m0s
[11:52:54.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:47:0)
[11:52:54.463] Timer tick, asking Buildbucket for the build status
[11:52:54.733] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:54.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:48:0) after 1m0s
[11:53:54.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:48:0)
[11:53:54.821] Timer tick, asking Buildbucket for the build status
[11:53:54.898] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:54.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:49:0) after 1m0s
[11:54:55.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:49:0)
[11:54:55.581] Timer tick, asking Buildbucket for the build status
[11:54:55.737] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:55.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:50:0) after 1m0s
[11:55:55.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:50:0)
[11:55:55.892] Timer tick, asking Buildbucket for the build status
[11:55:56.072] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:56.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:51:0) after 1m0s
[11:56:56.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:51:0)
[11:56:56.265] Timer tick, asking Buildbucket for the build status
[11:56:56.352] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:56.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:52:0) after 1m0s
[11:57:56.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:52:0)
[11:57:56.370] Timer tick, asking Buildbucket for the build status
[11:57:56.477] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:56.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:53:0) after 1m0s
[11:58:56.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:53:0)
[11:58:56.571] Timer tick, asking Buildbucket for the build status
[11:58:56.874] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:56.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:54:0) after 1m0s
[11:59:56.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:54:0)
[11:59:56.929] Timer tick, asking Buildbucket for the build status
[11:59:57.168] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:57.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:55:0) after 1m0s
[12:00:57.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:55:0)
[12:00:57.249] Timer tick, asking Buildbucket for the build status
[12:00:57.420] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:57.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:56:0) after 1m0s
[12:01:57.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:56:0)
[12:01:57.692] Timer tick, asking Buildbucket for the build status
[12:01:57.785] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:57.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:57:0) after 1m0s
[12:02:57.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:57:0)
[12:02:57.877] Timer tick, asking Buildbucket for the build status
[12:02:58.035] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:58.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:58:0) after 1m0s
[12:03:58.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:58:0)
[12:03:58.092] Timer tick, asking Buildbucket for the build status
[12:03:58.158] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:58.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:59:0) after 1m0s
[12:04:58.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:59:0)
[12:04:58.213] Timer tick, asking Buildbucket for the build status
[12:04:58.352] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:58.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:60:0) after 1m0s
[12:05:58.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:60:0)
[12:05:58.403] Timer tick, asking Buildbucket for the build status
[12:05:58.477] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:58.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:61:0) after 1m0s
[12:06:58.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:61:0)
[12:06:58.542] Timer tick, asking Buildbucket for the build status
[12:06:58.760] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:58.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:62:0) after 1m0s
[12:07:58.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:62:0)
[12:07:58.806] Timer tick, asking Buildbucket for the build status
[12:08:06.419] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:06.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:63:0) after 1m0s
[12:09:06.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:63:0)
[12:09:06.661] Timer tick, asking Buildbucket for the build status
[12:09:07.469] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:07.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:64:0) after 1m0s
[12:10:07.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:64:0)
[12:10:07.522] Timer tick, asking Buildbucket for the build status
[12:10:07.664] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:07.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:65:0) after 1m0s
[12:11:07.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:65:0)
[12:11:07.741] Timer tick, asking Buildbucket for the build status
[12:11:07.871] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:07.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:66:0) after 1m0s
[12:12:07.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:66:0)
[12:12:07.920] Timer tick, asking Buildbucket for the build status
[12:12:08.183] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:08.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:67:0) after 1m0s
[12:13:08.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:67:0)
[12:13:08.166] Timer tick, asking Buildbucket for the build status
[12:13:08.276] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:08.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:68:0) after 1m0s
[12:14:08.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:68:0)
[12:14:08.384] Timer tick, asking Buildbucket for the build status
[12:14:08.488] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:08.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:69:0) after 1m0s
[12:15:08.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:69:0)
[12:15:08.599] Timer tick, asking Buildbucket for the build status
[12:15:08.746] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:08.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:70:0) after 1m0s
[12:16:08.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:70:0)
[12:16:08.838] Timer tick, asking Buildbucket for the build status
[12:16:08.934] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:08.934] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:71:0) after 1m0s
[12:17:08.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:71:0)
[12:17:08.977] Timer tick, asking Buildbucket for the build status
[12:17:09.038] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:09.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:72:0) after 1m0s
[12:18:09.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:72:0)
[12:18:09.158] Timer tick, asking Buildbucket for the build status
[12:18:09.342] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:09.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:73:0) after 1m0s
[12:19:09.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:73:0)
[12:19:09.477] Timer tick, asking Buildbucket for the build status
[12:19:09.568] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:09.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:74:0) after 1m0s
[12:20:09.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:74:0)
[12:20:09.670] Timer tick, asking Buildbucket for the build status
[12:20:09.831] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:09.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:75:0) after 1m0s
[12:21:10.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:75:0)
[12:21:10.007] Timer tick, asking Buildbucket for the build status
[12:21:10.075] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:10.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:76:0) after 1m0s
[12:22:10.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:76:0)
[12:22:10.109] Timer tick, asking Buildbucket for the build status
[12:22:10.201] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:10.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:77:0) after 1m0s
[12:23:10.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:77:0)
[12:23:10.191] Timer tick, asking Buildbucket for the build status
[12:23:10.287] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:10.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:78:0) after 1m0s
[12:24:10.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:78:0)
[12:24:10.404] Timer tick, asking Buildbucket for the build status
[12:24:10.486] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:10.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:79:0) after 1m0s
[12:25:11.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:79:0)
[12:25:11.763] Timer tick, asking Buildbucket for the build status
[12:25:12.356] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:12.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:80:0) after 1m0s
[12:26:12.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:80:0)
[12:26:12.571] Timer tick, asking Buildbucket for the build status
[12:26:12.641] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:12.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:81:0) after 1m0s
[12:27:12.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:81:0)
[12:27:12.784] Timer tick, asking Buildbucket for the build status
[12:27:12.851] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:12.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:82:0) after 1m0s
[12:28:13.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:82:0)
[12:28:13.115] Timer tick, asking Buildbucket for the build status
[12:28:13.578] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:13.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:83:0) after 1m0s
[12:29:13.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:83:0)
[12:29:13.692] Timer tick, asking Buildbucket for the build status
[12:29:13.825] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:13.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:84:0) after 1m0s
[12:30:13.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:84:0)
[12:30:13.954] Timer tick, asking Buildbucket for the build status
[12:30:14.060] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:14.060] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:85:0) after 1m0s
[12:31:14.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:85:0)
[12:31:14.190] Timer tick, asking Buildbucket for the build status
[12:31:14.411] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:14.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:86:0) after 1m0s
[12:32:14.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:86:0)
[12:32:14.531] Timer tick, asking Buildbucket for the build status
[12:32:15.042] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:15.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:87:0) after 1m0s
[12:33:15.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:87:0)
[12:33:15.159] Timer tick, asking Buildbucket for the build status
[12:33:15.987] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:15.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:88:0) after 1m0s
[12:34:16.010] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:88:0)
[12:34:16.010] Timer tick, asking Buildbucket for the build status
[12:34:16.177] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:16.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:89:0) after 1m0s
[12:35:16.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:89:0)
[12:35:16.221] Timer tick, asking Buildbucket for the build status
[12:35:16.297] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:16.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:90:0) after 1m0s
[12:36:16.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:90:0)
[12:36:16.307] Timer tick, asking Buildbucket for the build status
[12:36:16.479] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:16.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:91:0) after 1m0s
[12:37:16.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:91:0)
[12:37:16.530] Timer tick, asking Buildbucket for the build status
[12:37:16.602] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:16.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:92:0) after 1m0s
[12:38:16.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:92:0)
[12:38:16.685] Timer tick, asking Buildbucket for the build status
[12:38:16.880] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:16.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:93:0) after 1m0s
[12:39:17.120] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:93:0)
[12:39:17.120] Timer tick, asking Buildbucket for the build status
[12:39:17.194] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:17.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:94:0) after 1m0s
[12:40:17.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:94:0)
[12:40:17.344] Timer tick, asking Buildbucket for the build status
[12:40:17.430] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:17.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:95:0) after 1m0s
[12:41:17.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:95:0)
[12:41:17.463] Timer tick, asking Buildbucket for the build status
[12:41:17.562] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:17.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:96:0) after 1m0s
[12:42:17.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:96:0)
[12:42:17.900] Timer tick, asking Buildbucket for the build status
[12:42:18.042] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:18.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:97:0) after 1m0s
[12:43:18.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:97:0)
[12:43:18.308] Timer tick, asking Buildbucket for the build status
[12:43:18.551] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:18.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:98:0) after 1m0s
[12:44:18.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:98:0)
[12:44:18.645] Timer tick, asking Buildbucket for the build status
[12:44:18.699] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:18.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:99:0) after 1m0s
[12:45:18.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:99:0)
[12:45:18.860] Timer tick, asking Buildbucket for the build status
[12:45:18.925] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:18.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:100:0) after 1m0s
[12:46:18.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:100:0)
[12:46:18.981] Timer tick, asking Buildbucket for the build status
[12:46:19.057] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:19.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:101:0) after 1m0s
[12:47:19.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:101:0)
[12:47:19.314] Timer tick, asking Buildbucket for the build status
[12:47:19.403] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:19.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:102:0) after 1m0s
[12:48:19.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:102:0)
[12:48:19.488] Timer tick, asking Buildbucket for the build status
[12:48:19.667] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:19.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:103:0) after 1m0s
[12:49:19.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:103:0)
[12:49:19.700] Timer tick, asking Buildbucket for the build status
[12:49:19.777] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:19.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:104:0) after 1m0s
[12:50:19.888] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:104:0)
[12:50:19.888] Timer tick, asking Buildbucket for the build status
[12:50:19.993] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:19.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:105:0) after 1m0s
[12:51:20.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:105:0)
[12:51:20.149] Timer tick, asking Buildbucket for the build status
[12:51:20.225] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:20.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:106:0) after 1m0s
[12:52:20.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:106:0)
[12:52:20.250] Timer tick, asking Buildbucket for the build status
[12:52:20.334] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:20.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:107:0) after 1m0s
[12:53:20.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:107:0)
[12:53:20.449] Timer tick, asking Buildbucket for the build status
[12:53:20.569] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:20.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:108:0) after 1m0s
[12:54:20.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:108:0)
[12:54:20.705] Timer tick, asking Buildbucket for the build status
[12:54:20.785] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:20.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:109:0) after 1m0s
[12:55:20.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:109:0)
[12:55:20.960] Timer tick, asking Buildbucket for the build status
[12:55:21.025] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:21.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:110:0) after 1m0s
[12:56:21.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:110:0)
[12:56:21.003] Timer tick, asking Buildbucket for the build status
[12:56:21.062] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:21.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:111:0) after 1m0s
[12:57:21.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:111:0)
[12:57:21.132] Timer tick, asking Buildbucket for the build status
[12:57:21.909] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:21.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:112:0) after 1m0s
[12:58:22.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:112:0)
[12:58:22.076] Timer tick, asking Buildbucket for the build status
[12:58:22.279] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:22.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:113:0) after 1m0s
[12:59:22.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:113:0)
[12:59:22.452] Timer tick, asking Buildbucket for the build status
[12:59:22.524] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:22.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:114:0) after 1m0s
[13:00:22.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:114:0)
[13:00:22.665] Timer tick, asking Buildbucket for the build status
[13:00:22.751] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:22.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:115:0) after 1m0s
[13:01:22.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:115:0)
[13:01:22.849] Timer tick, asking Buildbucket for the build status
[13:01:22.993] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:22.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:116:0) after 1m0s
[13:02:23.030] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:116:0)
[13:02:23.030] Timer tick, asking Buildbucket for the build status
[13:02:23.111] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:23.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:117:0) after 1m0s
[13:03:23.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:117:0)
[13:03:23.202] Timer tick, asking Buildbucket for the build status
[13:03:23.390] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:23.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:118:0) after 1m0s
[13:04:23.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:118:0)
[13:04:23.526] Timer tick, asking Buildbucket for the build status
[13:04:23.589] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:23.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:119:0) after 1m0s
[13:05:23.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:119:0)
[13:05:23.709] Timer tick, asking Buildbucket for the build status
[13:05:23.787] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:23.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:120:0) after 1m0s
[13:06:23.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:120:0)
[13:06:23.933] Timer tick, asking Buildbucket for the build status
[13:06:24.005] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:24.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:121:0) after 1m0s
[13:07:24.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:121:0)
[13:07:24.118] Timer tick, asking Buildbucket for the build status
[13:07:24.203] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:24.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:122:0) after 1m0s
[13:08:24.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:122:0)
[13:08:24.421] Timer tick, asking Buildbucket for the build status
[13:08:24.606] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:24.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:123:0) after 1m0s
[13:09:24.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:123:0)
[13:09:24.892] Timer tick, asking Buildbucket for the build status
[13:09:24.962] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:24.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:124:0) after 1m0s
[13:10:25.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:124:0)
[13:10:25.109] Timer tick, asking Buildbucket for the build status
[13:10:25.170] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:25.170] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:125:0) after 1m0s
[13:11:25.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:125:0)
[13:11:25.382] Timer tick, asking Buildbucket for the build status
[13:11:25.853] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:25.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:126:0) after 1m0s
[13:12:25.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:126:0)
[13:12:25.923] Timer tick, asking Buildbucket for the build status
[13:12:26.065] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:26.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:127:0) after 1m0s
[13:13:26.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:127:0)
[13:13:26.173] Timer tick, asking Buildbucket for the build status
[13:13:26.401] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:26.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:128:0) after 1m0s
[13:14:26.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:128:0)
[13:14:26.439] Timer tick, asking Buildbucket for the build status
[13:14:26.509] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:26.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:129:0) after 1m0s
[13:15:26.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:129:0)
[13:15:26.553] Timer tick, asking Buildbucket for the build status
[13:15:26.625] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:26.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:130:0) after 1m0s
[13:16:26.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:130:0)
[13:16:26.753] Timer tick, asking Buildbucket for the build status
[13:16:26.840] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:26.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:131:0) after 1m0s
[13:17:26.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:131:0)
[13:17:26.924] Timer tick, asking Buildbucket for the build status
[13:17:27.004] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:27.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:132:0) after 1m0s
[13:18:27.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:132:0)
[13:18:27.202] Timer tick, asking Buildbucket for the build status
[13:18:27.323] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:27.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:133:0) after 1m0s
[13:19:27.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:133:0)
[13:19:27.413] Timer tick, asking Buildbucket for the build status
[13:19:27.481] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:27.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:134:0) after 1m0s
[13:20:27.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:134:0)
[13:20:27.589] Timer tick, asking Buildbucket for the build status
[13:20:27.643] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:27.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:135:0) after 1m0s
[13:21:27.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:135:0)
[13:21:27.756] Timer tick, asking Buildbucket for the build status
[13:21:27.823] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:27.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:136:0) after 1m0s
[13:22:27.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:136:0)
[13:22:27.929] Timer tick, asking Buildbucket for the build status
[13:22:28.085] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:28.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:137:0) after 1m0s
[13:23:28.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:137:0)
[13:23:28.216] Timer tick, asking Buildbucket for the build status
[13:23:28.348] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:28.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:138:0) after 1m0s
[13:24:28.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:138:0)
[13:24:28.440] Timer tick, asking Buildbucket for the build status
[13:24:28.619] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:28.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:139:0) after 1m0s
[13:25:29.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:139:0)
[13:25:29.002] Timer tick, asking Buildbucket for the build status
[13:25:29.160] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:29.160] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:140:0) after 1m0s
[13:26:29.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:140:0)
[13:26:29.317] Timer tick, asking Buildbucket for the build status
[13:26:29.426] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:29.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:141:0) after 1m0s
[13:27:29.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:141:0)
[13:27:29.571] Timer tick, asking Buildbucket for the build status
[13:27:29.666] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:29.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:142:0) after 1m0s
[13:28:29.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:142:0)
[13:28:29.680] Timer tick, asking Buildbucket for the build status
[13:28:30.117] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:30.117] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:143:0) after 1m0s
[13:29:30.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:143:0)
[13:29:30.189] Timer tick, asking Buildbucket for the build status
[13:29:30.252] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:30.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:144:0) after 1m0s
[13:30:30.310] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:144:0)
[13:30:30.310] Timer tick, asking Buildbucket for the build status
[13:30:30.426] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:30.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:145:0) after 1m0s
[13:31:30.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:145:0)
[13:31:30.453] Timer tick, asking Buildbucket for the build status
[13:31:30.608] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:30.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:146:0) after 1m0s
[13:32:30.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:146:0)
[13:32:30.696] Timer tick, asking Buildbucket for the build status
[13:32:30.797] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:30.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:147:0) after 1m0s
[13:33:30.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:147:0)
[13:33:30.904] Timer tick, asking Buildbucket for the build status
[13:33:31.017] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:31.017] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:148:0) after 1m0s
[13:34:31.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:148:0)
[13:34:31.117] Timer tick, asking Buildbucket for the build status
[13:34:31.334] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:31.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:149:0) after 1m0s
[13:35:31.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:149:0)
[13:35:31.454] Timer tick, asking Buildbucket for the build status
[13:35:31.551] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:31.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:150:0) after 1m0s
[13:36:31.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:150:0)
[13:36:31.601] Timer tick, asking Buildbucket for the build status
[13:36:31.676] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:31.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:151:0) after 1m0s
[13:37:31.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:151:0)
[13:37:31.700] Timer tick, asking Buildbucket for the build status
[13:37:31.775] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:31.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:152:0) after 1m0s
[13:38:31.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:152:0)
[13:38:31.869] Timer tick, asking Buildbucket for the build status
[13:38:32.070] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:32.070] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:153:0) after 1m0s
[13:39:32.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:153:0)
[13:39:32.132] Timer tick, asking Buildbucket for the build status
[13:39:32.204] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:32.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:154:0) after 1m0s
[13:40:32.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:154:0)
[13:40:32.278] Timer tick, asking Buildbucket for the build status
[13:40:32.400] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:32.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:155:0) after 1m0s
[13:41:32.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:155:0)
[13:41:32.432] Timer tick, asking Buildbucket for the build status
[13:41:32.505] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:32.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:156:0) after 1m0s
[13:42:32.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:156:0)
[13:42:32.603] Timer tick, asking Buildbucket for the build status
[13:42:32.841] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:32.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:157:0) after 1m0s
[13:43:32.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:157:0)
[13:43:32.917] Timer tick, asking Buildbucket for the build status
[13:43:33.075] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:33.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:158:0) after 1m0s
[13:44:33.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:158:0)
[13:44:33.161] Timer tick, asking Buildbucket for the build status
[13:44:33.235] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:33.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:159:0) after 1m0s
[13:45:33.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:159:0)
[13:45:33.341] Timer tick, asking Buildbucket for the build status
[13:45:33.405] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:33.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:160:0) after 1m0s
[13:46:33.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:160:0)
[13:46:33.474] Timer tick, asking Buildbucket for the build status
[13:46:33.582] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:33.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:161:0) after 1m0s
[13:47:33.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:161:0)
[13:47:33.656] Timer tick, asking Buildbucket for the build status
[13:47:33.763] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:33.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:162:0) after 1m0s
[13:48:33.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:162:0)
[13:48:33.816] Timer tick, asking Buildbucket for the build status
[13:48:33.982] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:33.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:163:0) after 1m0s
[13:49:34.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:163:0)
[13:49:34.024] Timer tick, asking Buildbucket for the build status
[13:49:34.107] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:34.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:164:0) after 1m0s
[13:50:34.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:164:0)
[13:50:34.316] Timer tick, asking Buildbucket for the build status
[13:50:34.682] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:34.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:165:0) after 1m0s
[13:51:34.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:165:0)
[13:51:34.747] Timer tick, asking Buildbucket for the build status
[13:51:34.825] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:34.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:166:0) after 1m0s
[13:52:34.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:166:0)
[13:52:34.877] Timer tick, asking Buildbucket for the build status
[13:52:34.942] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:34.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:167:0) after 1m0s
[13:53:35.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:167:0)
[13:53:35.076] Timer tick, asking Buildbucket for the build status
[13:53:35.202] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:35.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:168:0) after 1m0s
[13:54:35.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:168:0)
[13:54:35.301] Timer tick, asking Buildbucket for the build status
[13:54:35.452] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:35.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:169:0) after 1m0s
[13:55:35.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:169:0)
[13:55:35.483] Timer tick, asking Buildbucket for the build status
[13:55:35.551] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:35.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:170:0) after 1m0s
[13:56:35.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:170:0)
[13:56:35.616] Timer tick, asking Buildbucket for the build status
[13:56:35.706] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:35.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:171:0) after 1m0s
[13:57:35.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:171:0)
[13:57:35.720] Timer tick, asking Buildbucket for the build status
[13:57:35.777] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:35.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:172:0) after 1m0s
[13:58:35.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:172:0)
[13:58:35.889] Timer tick, asking Buildbucket for the build status
[13:58:37.294] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:37.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:173:0) after 1m0s
[13:59:37.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:173:0)
[13:59:37.329] Timer tick, asking Buildbucket for the build status
[13:59:37.426] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:37.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:174:0) after 1m0s
[14:00:37.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:174:0)
[14:00:37.533] Timer tick, asking Buildbucket for the build status
[14:00:37.618] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:37.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:175:0) after 1m0s
[14:01:37.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:175:0)
[14:01:37.687] Timer tick, asking Buildbucket for the build status
[14:01:37.775] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:37.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:176:0) after 1m0s
[14:02:38.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:176:0)
[14:02:38.511] Timer tick, asking Buildbucket for the build status
[14:02:38.610] Build 8864113058273619632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:38.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029543120660787968:177:0) after 1m0s
[14:03:13.917] Received PubSub notification, asking Buildbucket for the build status
[14:03:13.991] Build 8864113058273619632: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:03:13.991] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1604930593086820",
"created_by": "project:infra",
"created_ts": "1604920060811499",
"id": "8864113058273619632",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4320.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"5da9138b-29ad-4fb4-8fb5-975d90af4255\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4320.0\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-3ga3\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604920116139319",
"status": "COMPLETED",
"status_changed_ts": "1604930593412175",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9029543120660787968",
"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/8864113058273619632/+/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:4fc5823f8e1ac710",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1604930593434371",
"url": "https://ci.chromium.org/b/8864113058273619632",
"utcnow_ts": "1604930593979989"
}
}
[14:03:13.991] Invocation finished in 2h55m34.839975462s with status SUCCEEDED