LUCI Scheduler :: infra :: Build From Tarball

Status: SUCCEEDED

Triggered by: chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com

Duration: 3 hours

Actions:

Definition (rev ef1333c7bf2cf95d15a0ce92acf83d24bcd6c5ac)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.infra.cron"
  builder: "Build From Tarball"
>

Incoming triggers

publish_tarball/0 (5 years ago by chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com)

Incoming properties

{
  "version": "84.0.4147.38"
}

Incoming tags

parent_buildername:publish_tarball
user_agent:recipe

Debug log (UTC)

[20:13:28.501] New invocation is queued and will start shortly
[20:13:28.501] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[20:13:29.603] Starting the invocation (attempt 1)
[20:13:29.657] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:13:29.657] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:13:29.658] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9043823101185939184",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"84.0.4147.38\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"4b3e367a-714c-4c48-abdc-ddf9e87ab9df\",\"title\":\"publish_tarball/0\"}]},\"version\":\"84.0.4147.38\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9043823101185939184",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[20:13:30.616] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1591301609844278",
    "id": "8878393039114570304",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4147.38\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"4b3e367a-714c-4c48-abdc-ddf9e87ab9df\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4147.38\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1591301610285211",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9043823101185939184",
      "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/8878393039114570304/+/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": "1591301610285356",
    "url": "https://ci.chromium.org/b/8878393039114570304",
    "utcnow_ts": "1591301610557257"
  }
}
[20:13:30.616] Task URL: https://ci.chromium.org/b/8878393039114570304
[20:13:30.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:2:0) after 1m0s
[20:14:30.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:2:0)
[20:14:30.611] Timer tick, asking Buildbucket for the build status
[20:14:31.353] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:31.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:3:0) after 1m0s
[20:15:31.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:3:0)
[20:15:31.401] Timer tick, asking Buildbucket for the build status
[20:15:31.579] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:31.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:4:0) after 1m0s
[20:16:31.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:4:0)
[20:16:31.674] Timer tick, asking Buildbucket for the build status
[20:16:32.087] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:32.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:5:0) after 1m0s
[20:17:32.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:5:0)
[20:17:32.113] Timer tick, asking Buildbucket for the build status
[20:17:32.311] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:32.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:6:0) after 1m0s
[20:18:32.360] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:6:0)
[20:18:32.360] Timer tick, asking Buildbucket for the build status
[20:18:32.659] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:18:32.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:7:0) after 1m0s
[20:19:32.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:7:0)
[20:19:32.655] Timer tick, asking Buildbucket for the build status
[20:19:32.821] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:19:32.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:8:0) after 1m0s
[20:20:32.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:8:0)
[20:20:32.901] Timer tick, asking Buildbucket for the build status
[20:20:33.150] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:20:33.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:9:0) after 1m0s
[20:21:33.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:9:0)
[20:21:33.205] Timer tick, asking Buildbucket for the build status
[20:21:33.506] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:21:33.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:10:0) after 1m0s
[20:22:33.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:10:0)
[20:22:33.549] Timer tick, asking Buildbucket for the build status
[20:22:33.726] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:22:33.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:11:0) after 1m0s
[20:23:33.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:11:0)
[20:23:33.758] Timer tick, asking Buildbucket for the build status
[20:23:34.214] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:23:34.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:12:0) after 1m0s
[20:24:34.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:12:0)
[20:24:34.253] Timer tick, asking Buildbucket for the build status
[20:24:34.637] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:24:34.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:13:0) after 1m0s
[20:25:34.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:13:0)
[20:25:34.732] Timer tick, asking Buildbucket for the build status
[20:25:34.860] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:25:34.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:14:0) after 1m0s
[20:26:34.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:14:0)
[20:26:34.879] Timer tick, asking Buildbucket for the build status
[20:26:35.184] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:26:35.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:15:0) after 1m0s
[20:27:35.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:15:0)
[20:27:35.211] Timer tick, asking Buildbucket for the build status
[20:27:35.351] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:27:35.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:16:0) after 1m0s
[20:28:35.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:16:0)
[20:28:35.407] Timer tick, asking Buildbucket for the build status
[20:28:36.494] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:36.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:17:0) after 1m0s
[20:29:36.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:17:0)
[20:29:36.564] Timer tick, asking Buildbucket for the build status
[20:29:37.096] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:29:37.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:18:0) after 1m0s
[20:30:37.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:18:0)
[20:30:37.150] Timer tick, asking Buildbucket for the build status
[20:30:37.702] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:30:37.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:19:0) after 1m0s
[20:31:37.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:19:0)
[20:31:37.725] Timer tick, asking Buildbucket for the build status
[20:31:37.893] Build 8878393039114570304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:37.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:20:0) after 1m0s
[20:32:17.690] Received PubSub notification, asking Buildbucket for the build status
[20:32:17.854] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:37.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:20:0)
[20:32:37.917] Timer tick, asking Buildbucket for the build status
[20:32:38.015] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:38.015] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:22:0) after 1m0s
[20:33:38.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:22:0)
[20:33:38.124] Timer tick, asking Buildbucket for the build status
[20:33:38.312] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:38.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:23:0) after 1m0s
[20:34:38.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:23:0)
[20:34:38.390] Timer tick, asking Buildbucket for the build status
[20:34:38.571] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:38.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:24:0) after 1m0s
[20:35:38.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:24:0)
[20:35:38.672] Timer tick, asking Buildbucket for the build status
[20:35:39.214] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:39.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:25:0) after 1m0s
[20:36:39.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:25:0)
[20:36:39.242] Timer tick, asking Buildbucket for the build status
[20:36:39.447] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:39.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:26:0) after 1m0s
[20:37:39.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:26:0)
[20:37:39.593] Timer tick, asking Buildbucket for the build status
[20:37:39.716] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:39.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:27:0) after 1m0s
[20:38:39.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:27:0)
[20:38:39.876] Timer tick, asking Buildbucket for the build status
[20:38:40.092] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:40.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:28:0) after 1m0s
[20:39:40.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:28:0)
[20:39:40.217] Timer tick, asking Buildbucket for the build status
[20:39:41.781] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:41.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:29:0) after 1m0s
[20:40:41.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:29:0)
[20:40:41.801] Timer tick, asking Buildbucket for the build status
[20:40:42.165] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:42.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:30:0) after 1m0s
[20:41:42.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:30:0)
[20:41:42.264] Timer tick, asking Buildbucket for the build status
[20:41:42.566] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:42.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:31:0) after 1m0s
[20:42:42.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:31:0)
[20:42:42.593] Timer tick, asking Buildbucket for the build status
[20:42:43.471] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:43.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:32:0) after 1m0s
[20:43:43.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:32:0)
[20:43:43.485] Timer tick, asking Buildbucket for the build status
[20:43:44.856] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:44.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:33:0) after 1m0s
[20:44:44.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:33:0)
[20:44:44.901] Timer tick, asking Buildbucket for the build status
[20:44:45.532] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:45.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:34:0) after 1m0s
[20:45:45.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:34:0)
[20:45:45.593] Timer tick, asking Buildbucket for the build status
[20:45:45.884] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:45.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:35:0) after 1m0s
[20:46:45.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:35:0)
[20:46:45.988] Timer tick, asking Buildbucket for the build status
[20:46:46.643] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:46.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:36:0) after 1m0s
[20:47:46.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:36:0)
[20:47:46.691] Timer tick, asking Buildbucket for the build status
[20:47:46.927] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:46.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:37:0) after 1m0s
[20:48:47.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:37:0)
[20:48:47.104] Timer tick, asking Buildbucket for the build status
[20:48:47.323] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:47.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:38:0) after 1m0s
[20:49:48.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:38:0)
[20:49:48.346] Timer tick, asking Buildbucket for the build status
[20:49:48.569] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:48.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:39:0) after 1m0s
[20:50:50.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:39:0)
[20:50:50.089] Timer tick, asking Buildbucket for the build status
[20:50:50.321] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:50.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:40:0) after 1m0s
[20:51:50.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:40:0)
[20:51:50.349] Timer tick, asking Buildbucket for the build status
[20:51:50.602] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:50.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:41:0) after 1m0s
[20:52:50.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:41:0)
[20:52:50.740] Timer tick, asking Buildbucket for the build status
[20:52:50.882] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:50.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:42:0) after 1m0s
[20:53:51.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:42:0)
[20:53:51.174] Timer tick, asking Buildbucket for the build status
[20:53:51.362] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:51.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:43:0) after 1m0s
[20:54:51.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:43:0)
[20:54:51.611] Timer tick, asking Buildbucket for the build status
[20:54:51.887] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:51.887] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:44:0) after 1m0s
[20:55:51.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:44:0)
[20:55:51.911] Timer tick, asking Buildbucket for the build status
[20:55:52.232] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:52.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:45:0) after 1m0s
[20:56:52.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:45:0)
[20:56:52.397] Timer tick, asking Buildbucket for the build status
[20:56:52.720] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:52.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:46:0) after 1m0s
[20:57:52.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:46:0)
[20:57:52.812] Timer tick, asking Buildbucket for the build status
[20:57:53.102] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:53.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:47:0) after 1m0s
[20:58:53.130] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:47:0)
[20:58:53.130] Timer tick, asking Buildbucket for the build status
[20:58:53.567] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:53.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:48:0) after 1m0s
[20:59:53.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:48:0)
[20:59:53.590] Timer tick, asking Buildbucket for the build status
[20:59:53.952] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:53.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:49:0) after 1m0s
[21:00:54.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:49:0)
[21:00:54.057] Timer tick, asking Buildbucket for the build status
[21:00:54.247] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:54.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:50:0) after 1m0s
[21:01:54.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:50:0)
[21:01:54.264] Timer tick, asking Buildbucket for the build status
[21:01:54.378] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:54.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:51:0) after 1m0s
[21:02:54.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:51:0)
[21:02:54.494] Timer tick, asking Buildbucket for the build status
[21:02:54.829] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:54.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:52:0) after 1m0s
[21:03:54.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:52:0)
[21:03:54.958] Timer tick, asking Buildbucket for the build status
[21:03:55.195] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:55.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:53:0) after 1m0s
[21:04:55.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:53:0)
[21:04:55.286] Timer tick, asking Buildbucket for the build status
[21:04:55.552] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:55.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:54:0) after 1m0s
[21:05:55.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:54:0)
[21:05:55.575] Timer tick, asking Buildbucket for the build status
[21:05:55.926] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:55.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:55:0) after 1m0s
[21:06:55.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:55:0)
[21:06:55.941] Timer tick, asking Buildbucket for the build status
[21:06:56.354] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:56.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:56:0) after 1m0s
[21:07:56.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:56:0)
[21:07:56.407] Timer tick, asking Buildbucket for the build status
[21:07:56.808] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:56.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:57:0) after 1m0s
[21:08:56.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:57:0)
[21:08:56.896] Timer tick, asking Buildbucket for the build status
[21:08:57.152] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:57.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:58:0) after 1m0s
[21:09:57.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:58:0)
[21:09:57.147] Timer tick, asking Buildbucket for the build status
[21:09:57.348] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:57.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:59:0) after 1m0s
[21:10:57.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:59:0)
[21:10:57.370] Timer tick, asking Buildbucket for the build status
[21:10:57.608] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:57.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:60:0) after 1m0s
[21:11:57.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:60:0)
[21:11:57.636] Timer tick, asking Buildbucket for the build status
[21:11:57.800] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:57.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:61:0) after 1m0s
[21:12:57.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:61:0)
[21:12:57.837] Timer tick, asking Buildbucket for the build status
[21:12:58.052] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:58.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:62:0) after 1m0s
[21:13:58.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:62:0)
[21:13:58.151] Timer tick, asking Buildbucket for the build status
[21:13:58.380] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:58.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:63:0) after 1m0s
[21:14:58.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:63:0)
[21:14:58.433] Timer tick, asking Buildbucket for the build status
[21:14:59.324] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:59.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:64:0) after 1m0s
[21:15:59.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:64:0)
[21:15:59.372] Timer tick, asking Buildbucket for the build status
[21:15:59.508] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:59.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:65:0) after 1m0s
[21:16:59.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:65:0)
[21:16:59.557] Timer tick, asking Buildbucket for the build status
[21:16:59.709] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:59.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:66:0) after 1m0s
[21:17:59.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:66:0)
[21:17:59.751] Timer tick, asking Buildbucket for the build status
[21:18:00.167] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:00.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:67:0) after 1m0s
[21:19:00.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:67:0)
[21:19:00.200] Timer tick, asking Buildbucket for the build status
[21:19:00.503] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:00.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:68:0) after 1m0s
[21:20:00.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:68:0)
[21:20:00.576] Timer tick, asking Buildbucket for the build status
[21:20:00.846] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:00.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:69:0) after 1m0s
[21:21:01.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:69:0)
[21:21:01.507] Timer tick, asking Buildbucket for the build status
[21:21:01.742] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:01.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:70:0) after 1m0s
[21:22:02.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:70:0)
[21:22:02.487] Timer tick, asking Buildbucket for the build status
[21:22:02.769] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:02.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:71:0) after 1m0s
[21:23:02.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:71:0)
[21:23:02.886] Timer tick, asking Buildbucket for the build status
[21:23:04.561] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:04.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:72:0) after 1m0s
[21:24:04.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:72:0)
[21:24:04.614] Timer tick, asking Buildbucket for the build status
[21:24:05.301] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:05.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:73:0) after 1m0s
[21:25:05.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:73:0)
[21:25:05.312] Timer tick, asking Buildbucket for the build status
[21:25:06.231] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:06.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:74:0) after 1m0s
[21:26:06.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:74:0)
[21:26:06.288] Timer tick, asking Buildbucket for the build status
[21:26:06.744] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:06.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:75:0) after 1m0s
[21:27:06.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:75:0)
[21:27:06.769] Timer tick, asking Buildbucket for the build status
[21:27:06.906] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:06.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:76:0) after 1m0s
[21:28:06.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:76:0)
[21:28:06.919] Timer tick, asking Buildbucket for the build status
[21:28:07.065] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:07.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:77:0) after 1m0s
[21:29:07.100] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:77:0)
[21:29:07.100] Timer tick, asking Buildbucket for the build status
[21:29:07.338] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:07.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:78:0) after 1m0s
[21:30:07.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:78:0)
[21:30:07.389] Timer tick, asking Buildbucket for the build status
[21:30:09.860] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:09.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:79:0) after 1m0s
[21:31:09.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:79:0)
[21:31:09.904] Timer tick, asking Buildbucket for the build status
[21:31:10.315] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:10.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:80:0) after 1m0s
[21:32:10.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:80:0)
[21:32:10.419] Timer tick, asking Buildbucket for the build status
[21:32:10.857] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:10.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:81:0) after 1m0s
[21:33:10.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:81:0)
[21:33:10.919] Timer tick, asking Buildbucket for the build status
[21:33:11.108] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:11.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:82:0) after 1m0s
[21:34:11.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:82:0)
[21:34:11.198] Timer tick, asking Buildbucket for the build status
[21:34:11.981] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:11.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:83:0) after 1m0s
[21:35:11.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:83:0)
[21:35:11.985] Timer tick, asking Buildbucket for the build status
[21:35:12.188] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:12.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:84:0) after 1m0s
[21:36:12.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:84:0)
[21:36:12.231] Timer tick, asking Buildbucket for the build status
[21:36:12.739] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:12.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:85:0) after 1m0s
[21:37:12.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:85:0)
[21:37:12.801] Timer tick, asking Buildbucket for the build status
[21:37:13.119] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:13.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:86:0) after 1m0s
[21:38:13.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:86:0)
[21:38:13.161] Timer tick, asking Buildbucket for the build status
[21:38:13.283] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:13.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:87:0) after 1m0s
[21:39:13.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:87:0)
[21:39:13.357] Timer tick, asking Buildbucket for the build status
[21:39:13.481] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:13.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:88:0) after 1m0s
[21:40:13.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:88:0)
[21:40:13.483] Timer tick, asking Buildbucket for the build status
[21:40:14.379] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:14.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:89:0) after 1m0s
[21:41:14.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:89:0)
[21:41:14.407] Timer tick, asking Buildbucket for the build status
[21:41:14.544] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:14.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:90:0) after 1m0s
[21:42:14.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:90:0)
[21:42:14.600] Timer tick, asking Buildbucket for the build status
[21:42:14.806] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:14.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:91:0) after 1m0s
[21:43:14.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:91:0)
[21:43:14.870] Timer tick, asking Buildbucket for the build status
[21:43:14.983] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:14.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:92:0) after 1m0s
[21:44:14.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:92:0)
[21:44:14.984] Timer tick, asking Buildbucket for the build status
[21:44:16.658] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:16.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:93:0) after 1m0s
[21:45:16.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:93:0)
[21:45:16.773] Timer tick, asking Buildbucket for the build status
[21:45:17.061] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:17.061] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:94:0) after 1m0s
[21:46:17.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:94:0)
[21:46:17.151] Timer tick, asking Buildbucket for the build status
[21:46:17.471] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:17.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:95:0) after 1m0s
[21:47:17.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:95:0)
[21:47:17.505] Timer tick, asking Buildbucket for the build status
[21:47:17.942] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:17.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:96:0) after 1m0s
[21:48:18.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:96:0)
[21:48:18.036] Timer tick, asking Buildbucket for the build status
[21:48:18.373] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:18.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:97:0) after 1m0s
[21:49:18.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:97:0)
[21:49:18.394] Timer tick, asking Buildbucket for the build status
[21:49:18.494] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:18.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:98:0) after 1m0s
[21:50:18.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:98:0)
[21:50:18.520] Timer tick, asking Buildbucket for the build status
[21:50:18.759] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:18.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:99:0) after 1m0s
[21:51:18.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:99:0)
[21:51:18.819] Timer tick, asking Buildbucket for the build status
[21:51:18.975] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:18.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:100:0) after 1m0s
[21:52:19.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:100:0)
[21:52:19.031] Timer tick, asking Buildbucket for the build status
[21:52:19.386] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:19.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:101:0) after 1m0s
[21:53:19.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:101:0)
[21:53:19.483] Timer tick, asking Buildbucket for the build status
[21:53:20.016] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:20.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:102:0) after 1m0s
[21:54:20.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:102:0)
[21:54:20.077] Timer tick, asking Buildbucket for the build status
[21:54:20.246] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:20.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:103:0) after 1m0s
[21:55:20.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:103:0)
[21:55:20.242] Timer tick, asking Buildbucket for the build status
[21:55:20.402] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:20.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:104:0) after 1m0s
[21:56:20.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:104:0)
[21:56:20.414] Timer tick, asking Buildbucket for the build status
[21:56:20.554] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:20.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:105:0) after 1m0s
[21:57:20.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:105:0)
[21:57:20.586] Timer tick, asking Buildbucket for the build status
[21:57:20.721] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:20.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:106:0) after 1m0s
[21:58:20.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:106:0)
[21:58:20.923] Timer tick, asking Buildbucket for the build status
[21:58:21.104] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:21.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:107:0) after 1m0s
[21:59:21.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:107:0)
[21:59:21.364] Timer tick, asking Buildbucket for the build status
[21:59:21.500] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:21.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:108:0) after 1m0s
[22:00:21.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:108:0)
[22:00:21.680] Timer tick, asking Buildbucket for the build status
[22:00:21.821] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:21.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:109:0) after 1m0s
[22:01:21.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:109:0)
[22:01:21.801] Timer tick, asking Buildbucket for the build status
[22:01:22.069] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:22.070] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:110:0) after 1m0s
[22:02:22.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:110:0)
[22:02:22.094] Timer tick, asking Buildbucket for the build status
[22:02:22.250] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:22.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:111:0) after 1m0s
[22:03:22.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:111:0)
[22:03:22.361] Timer tick, asking Buildbucket for the build status
[22:03:22.517] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:22.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:112:0) after 1m0s
[22:04:22.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:112:0)
[22:04:22.698] Timer tick, asking Buildbucket for the build status
[22:04:22.953] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:22.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:113:0) after 1m0s
[22:05:22.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:113:0)
[22:05:22.948] Timer tick, asking Buildbucket for the build status
[22:05:23.298] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:23.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:114:0) after 1m0s
[22:06:23.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:114:0)
[22:06:23.376] Timer tick, asking Buildbucket for the build status
[22:06:23.511] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:23.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:115:0) after 1m0s
[22:07:23.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:115:0)
[22:07:23.607] Timer tick, asking Buildbucket for the build status
[22:07:23.834] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:23.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:116:0) after 1m0s
[22:08:23.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:116:0)
[22:08:23.859] Timer tick, asking Buildbucket for the build status
[22:08:24.395] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:24.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:117:0) after 1m0s
[22:09:24.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:117:0)
[22:09:24.446] Timer tick, asking Buildbucket for the build status
[22:09:24.728] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:24.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:118:0) after 1m0s
[22:10:24.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:118:0)
[22:10:24.831] Timer tick, asking Buildbucket for the build status
[22:10:25.012] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:25.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:119:0) after 1m0s
[22:11:25.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:119:0)
[22:11:25.071] Timer tick, asking Buildbucket for the build status
[22:11:25.791] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:25.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:120:0) after 1m0s
[22:12:25.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:120:0)
[22:12:25.834] Timer tick, asking Buildbucket for the build status
[22:12:27.126] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:27.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:121:0) after 1m0s
[22:13:27.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:121:0)
[22:13:27.295] Timer tick, asking Buildbucket for the build status
[22:13:27.783] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:27.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:122:0) after 1m0s
[22:14:28.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:122:0)
[22:14:28.035] Timer tick, asking Buildbucket for the build status
[22:14:29.122] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:29.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:123:0) after 1m0s
[22:15:29.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:123:0)
[22:15:29.223] Timer tick, asking Buildbucket for the build status
[22:15:29.450] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:29.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:124:0) after 1m0s
[22:16:29.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:124:0)
[22:16:29.468] Timer tick, asking Buildbucket for the build status
[22:16:29.621] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:29.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:125:0) after 1m0s
[22:17:29.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:125:0)
[22:17:29.712] Timer tick, asking Buildbucket for the build status
[22:17:31.276] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:31.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:126:0) after 1m0s
[22:18:31.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:126:0)
[22:18:31.453] Timer tick, asking Buildbucket for the build status
[22:18:31.772] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:31.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:127:0) after 1m0s
[22:19:31.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:127:0)
[22:19:31.814] Timer tick, asking Buildbucket for the build status
[22:19:32.024] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:32.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:128:0) after 1m0s
[22:20:32.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:128:0)
[22:20:32.055] Timer tick, asking Buildbucket for the build status
[22:20:32.217] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:32.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:129:0) after 1m0s
[22:21:32.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:129:0)
[22:21:32.248] Timer tick, asking Buildbucket for the build status
[22:21:32.515] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:32.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:130:0) after 1m0s
[22:22:32.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:130:0)
[22:22:32.563] Timer tick, asking Buildbucket for the build status
[22:22:32.870] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:32.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:131:0) after 1m0s
[22:23:32.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:131:0)
[22:23:32.903] Timer tick, asking Buildbucket for the build status
[22:23:33.246] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:33.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:132:0) after 1m0s
[22:24:33.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:132:0)
[22:24:33.281] Timer tick, asking Buildbucket for the build status
[22:24:33.883] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:33.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:133:0) after 1m0s
[22:25:33.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:133:0)
[22:25:33.924] Timer tick, asking Buildbucket for the build status
[22:25:34.045] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:34.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:134:0) after 1m0s
[22:26:34.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:134:0)
[22:26:34.091] Timer tick, asking Buildbucket for the build status
[22:26:34.298] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:34.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:135:0) after 1m0s
[22:27:34.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:135:0)
[22:27:34.312] Timer tick, asking Buildbucket for the build status
[22:27:34.616] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:34.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:136:0) after 1m0s
[22:28:34.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:136:0)
[22:28:34.645] Timer tick, asking Buildbucket for the build status
[22:28:34.873] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:34.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:137:0) after 1m0s
[22:29:34.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:137:0)
[22:29:34.985] Timer tick, asking Buildbucket for the build status
[22:29:35.419] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:35.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:138:0) after 1m0s
[22:30:35.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:138:0)
[22:30:35.477] Timer tick, asking Buildbucket for the build status
[22:30:35.887] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:35.887] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:139:0) after 1m0s
[22:31:35.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:139:0)
[22:31:35.878] Timer tick, asking Buildbucket for the build status
[22:31:36.155] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:36.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:140:0) after 1m0s
[22:32:36.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:140:0)
[22:32:36.210] Timer tick, asking Buildbucket for the build status
[22:32:36.348] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:36.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:141:0) after 1m0s
[22:33:36.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:141:0)
[22:33:36.366] Timer tick, asking Buildbucket for the build status
[22:33:36.833] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:36.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:142:0) after 1m0s
[22:34:36.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:142:0)
[22:34:36.877] Timer tick, asking Buildbucket for the build status
[22:34:37.032] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:37.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:143:0) after 1m0s
[22:35:37.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:143:0)
[22:35:37.159] Timer tick, asking Buildbucket for the build status
[22:35:37.493] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:37.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:144:0) after 1m0s
[22:36:37.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:144:0)
[22:36:37.549] Timer tick, asking Buildbucket for the build status
[22:36:37.928] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:37.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:145:0) after 1m0s
[22:37:38.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:145:0)
[22:37:38.001] Timer tick, asking Buildbucket for the build status
[22:37:38.131] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:38.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:146:0) after 1m0s
[22:38:38.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:146:0)
[22:38:38.355] Timer tick, asking Buildbucket for the build status
[22:38:38.744] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:38.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:147:0) after 1m0s
[22:39:38.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:147:0)
[22:39:38.789] Timer tick, asking Buildbucket for the build status
[22:39:39.132] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:39.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:148:0) after 1m0s
[22:40:39.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:148:0)
[22:40:39.174] Timer tick, asking Buildbucket for the build status
[22:40:39.782] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:39.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:149:0) after 1m0s
[22:41:39.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:149:0)
[22:41:39.923] Timer tick, asking Buildbucket for the build status
[22:41:40.104] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:40.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:150:0) after 1m0s
[22:42:40.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:150:0)
[22:42:40.141] Timer tick, asking Buildbucket for the build status
[22:42:40.401] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:40.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:151:0) after 1m0s
[22:43:40.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:151:0)
[22:43:40.487] Timer tick, asking Buildbucket for the build status
[22:43:40.919] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:40.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:152:0) after 1m0s
[22:44:40.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:152:0)
[22:44:40.967] Timer tick, asking Buildbucket for the build status
[22:44:41.105] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:41.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:153:0) after 1m0s
[22:45:41.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:153:0)
[22:45:41.156] Timer tick, asking Buildbucket for the build status
[22:45:41.335] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:41.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:154:0) after 1m0s
[22:46:42.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:154:0)
[22:46:42.164] Timer tick, asking Buildbucket for the build status
[22:46:42.555] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:42.555] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:155:0) after 1m0s
[22:47:42.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:155:0)
[22:47:42.593] Timer tick, asking Buildbucket for the build status
[22:47:42.955] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:42.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:156:0) after 1m0s
[22:48:43.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:156:0)
[22:48:43.011] Timer tick, asking Buildbucket for the build status
[22:48:43.172] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:43.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:157:0) after 1m0s
[22:49:43.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:157:0)
[22:49:43.366] Timer tick, asking Buildbucket for the build status
[22:49:43.463] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:43.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:158:0) after 1m0s
[22:50:43.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:158:0)
[22:50:43.546] Timer tick, asking Buildbucket for the build status
[22:50:43.683] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:43.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:159:0) after 1m0s
[22:51:43.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:159:0)
[22:51:43.720] Timer tick, asking Buildbucket for the build status
[22:51:43.875] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:43.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:160:0) after 1m0s
[22:52:43.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:160:0)
[22:52:43.925] Timer tick, asking Buildbucket for the build status
[22:52:44.730] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:44.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:161:0) after 1m0s
[22:53:44.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:161:0)
[22:53:44.780] Timer tick, asking Buildbucket for the build status
[22:53:45.089] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:45.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:162:0) after 1m0s
[22:54:45.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:162:0)
[22:54:45.112] Timer tick, asking Buildbucket for the build status
[22:54:45.313] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:45.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:163:0) after 1m0s
[22:55:45.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:163:0)
[22:55:45.367] Timer tick, asking Buildbucket for the build status
[22:55:45.493] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:45.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:164:0) after 1m0s
[22:56:45.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:164:0)
[22:56:45.716] Timer tick, asking Buildbucket for the build status
[22:56:45.825] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:45.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:165:0) after 1m0s
[22:57:46.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:165:0)
[22:57:46.028] Timer tick, asking Buildbucket for the build status
[22:57:46.250] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:46.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:166:0) after 1m0s
[22:58:46.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:166:0)
[22:58:46.379] Timer tick, asking Buildbucket for the build status
[22:58:46.554] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:46.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:167:0) after 1m0s
[22:59:46.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:167:0)
[22:59:46.594] Timer tick, asking Buildbucket for the build status
[22:59:47.101] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:47.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:168:0) after 1m0s
[23:00:47.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:168:0)
[23:00:47.163] Timer tick, asking Buildbucket for the build status
[23:00:47.477] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:47.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:169:0) after 1m0s
[23:01:47.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:169:0)
[23:01:47.533] Timer tick, asking Buildbucket for the build status
[23:01:47.711] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:47.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:170:0) after 1m0s
[23:02:47.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:170:0)
[23:02:47.825] Timer tick, asking Buildbucket for the build status
[23:02:48.002] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:48.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:171:0) after 1m0s
[23:03:48.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:171:0)
[23:03:48.049] Timer tick, asking Buildbucket for the build status
[23:03:49.799] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:49.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:172:0) after 1m0s
[23:04:49.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:172:0)
[23:04:49.890] Timer tick, asking Buildbucket for the build status
[23:04:50.021] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:50.021] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:173:0) after 1m0s
[23:05:50.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:173:0)
[23:05:50.198] Timer tick, asking Buildbucket for the build status
[23:05:51.904] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:51.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:174:0) after 1m0s
[23:06:51.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:174:0)
[23:06:51.949] Timer tick, asking Buildbucket for the build status
[23:06:53.554] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:53.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:175:0) after 1m0s
[23:07:53.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:175:0)
[23:07:53.599] Timer tick, asking Buildbucket for the build status
[23:07:54.084] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:54.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:176:0) after 1m0s
[23:08:54.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:176:0)
[23:08:54.183] Timer tick, asking Buildbucket for the build status
[23:08:54.464] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:54.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:177:0) after 1m0s
[23:09:54.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:177:0)
[23:09:54.559] Timer tick, asking Buildbucket for the build status
[23:09:54.837] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:54.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:178:0) after 1m0s
[23:10:54.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:178:0)
[23:10:54.868] Timer tick, asking Buildbucket for the build status
[23:10:55.742] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:55.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:179:0) after 1m0s
[23:11:55.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:179:0)
[23:11:55.866] Timer tick, asking Buildbucket for the build status
[23:11:56.063] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:56.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:180:0) after 1m0s
[23:12:56.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:180:0)
[23:12:56.116] Timer tick, asking Buildbucket for the build status
[23:12:56.415] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:56.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:181:0) after 1m0s
[23:13:56.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:181:0)
[23:13:56.537] Timer tick, asking Buildbucket for the build status
[23:13:56.685] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:56.685] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:182:0) after 1m0s
[23:14:56.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:182:0)
[23:14:56.719] Timer tick, asking Buildbucket for the build status
[23:14:56.971] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:56.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:183:0) after 1m0s
[23:15:57.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:183:0)
[23:15:57.066] Timer tick, asking Buildbucket for the build status
[23:15:57.439] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:57.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:184:0) after 1m0s
[23:16:57.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:184:0)
[23:16:57.507] Timer tick, asking Buildbucket for the build status
[23:16:59.581] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:59.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:185:0) after 1m0s
[23:17:59.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:185:0)
[23:17:59.659] Timer tick, asking Buildbucket for the build status
[23:17:59.888] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:59.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:186:0) after 1m0s
[23:19:00.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:186:0)
[23:19:00.001] Timer tick, asking Buildbucket for the build status
[23:19:00.318] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:00.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:187:0) after 1m0s
[23:20:00.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:187:0)
[23:20:00.350] Timer tick, asking Buildbucket for the build status
[23:20:01.181] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:01.181] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:188:0) after 1m0s
[23:21:01.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:188:0)
[23:21:01.393] Timer tick, asking Buildbucket for the build status
[23:21:01.534] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:01.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:189:0) after 1m0s
[23:22:01.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:189:0)
[23:22:01.755] Timer tick, asking Buildbucket for the build status
[23:22:02.116] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:02.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:190:0) after 1m0s
[23:23:04.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:190:0)
[23:23:04.087] Timer tick, asking Buildbucket for the build status
[23:23:04.219] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:04.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:191:0) after 1m0s
[23:24:04.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:191:0)
[23:24:04.253] Timer tick, asking Buildbucket for the build status
[23:24:04.461] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:04.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:192:0) after 1m0s
[23:25:04.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:192:0)
[23:25:04.499] Timer tick, asking Buildbucket for the build status
[23:25:04.835] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:04.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:193:0) after 1m0s
[23:26:04.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:193:0)
[23:26:04.929] Timer tick, asking Buildbucket for the build status
[23:26:05.097] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:05.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:194:0) after 1m0s
[23:27:05.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:194:0)
[23:27:05.192] Timer tick, asking Buildbucket for the build status
[23:27:05.435] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:05.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:195:0) after 1m0s
[23:28:05.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:195:0)
[23:28:05.666] Timer tick, asking Buildbucket for the build status
[23:28:05.860] Build 8878393039114570304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:05.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043823101185939184:196:0) after 1m0s
[23:28:52.661] Received PubSub notification, asking Buildbucket for the build status
[23:28:52.894] Build 8878393039114570304: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:28:52.894] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1591313331882390",
    "created_by": "project:infra",
    "created_ts": "1591301609844278",
    "id": "8878393039114570304",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4147.38\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"4b3e367a-714c-4c48-abdc-ddf9e87ab9df\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4147.38\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"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-qx2l\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5158-af0aabf\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1591302736135141",
    "status": "COMPLETED",
    "status_changed_ts": "1591313332330904",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9043823101185939184",
      "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/8878393039114570304/+/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:4c99c92597094710",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1591313332344713",
    "url": "https://ci.chromium.org/b/8878393039114570304",
    "utcnow_ts": "1591313332867518"
  }
}
[23:28:52.894] Invocation finished in 3h15m24.409188895s with status SUCCEEDED