LUCI Scheduler :: infra :: Build From Tarball

Status: FAILED

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

Duration: 4 hours

Actions:

Definition (rev db79390766c74b5c78e905f2f711f95842d49a9d)

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": "87.0.4280.5"
}

Incoming tags

parent_buildername:publish_tarball
user_agent:recipe

Debug log (UTC)

[14:47:28.235] New invocation is queued and will start shortly
[14:47:28.235] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[14:47:29.359] Starting the invocation (attempt 1)
[14:47:29.390] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:47:29.390] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:47:29.390] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9032790781713404928",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"87.0.4280.5\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"ea471987-959f-4adf-8be1-f83f848307c0\",\"title\":\"publish_tarball/0\"}]},\"version\":\"87.0.4280.5\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9032790781713404928",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[14:47:29.828] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1601822849472632",
    "id": "8867360719750165264",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4280.5\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ea471987-959f-4adf-8be1-f83f848307c0\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4280.5\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1601822849657024",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9032790781713404928",
      "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/8867360719750165264/+/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": "1601822849657134",
    "url": "https://ci.chromium.org/b/8867360719750165264",
    "utcnow_ts": "1601822849821305"
  }
}
[14:47:29.828] Task URL: https://ci.chromium.org/b/8867360719750165264
[14:47:29.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:2:0) after 1m0s
[14:48:29.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:2:0)
[14:48:29.846] Timer tick, asking Buildbucket for the build status
[14:48:30.089] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:48:30.089] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:3:0) after 1m0s
[14:49:30.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:3:0)
[14:49:30.183] Timer tick, asking Buildbucket for the build status
[14:49:30.289] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:49:30.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:4:0) after 1m0s
[14:50:30.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:4:0)
[14:50:30.309] Timer tick, asking Buildbucket for the build status
[14:50:30.398] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:50:30.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:5:0) after 1m0s
[14:51:30.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:5:0)
[14:51:30.449] Timer tick, asking Buildbucket for the build status
[14:51:30.715] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:51:30.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:6:0) after 1m0s
[14:52:30.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:6:0)
[14:52:30.726] Timer tick, asking Buildbucket for the build status
[14:52:31.150] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:52:31.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:7:0) after 1m0s
[14:53:31.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:7:0)
[14:53:31.246] Timer tick, asking Buildbucket for the build status
[14:53:31.473] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:53:31.473] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:8:0) after 1m0s
[14:54:31.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:8:0)
[14:54:31.497] Timer tick, asking Buildbucket for the build status
[14:54:32.358] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:54:32.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:9:0) after 1m0s
[14:55:32.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:9:0)
[14:55:32.447] Timer tick, asking Buildbucket for the build status
[14:55:32.584] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:55:32.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:10:0) after 1m0s
[14:56:32.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:10:0)
[14:56:32.617] Timer tick, asking Buildbucket for the build status
[14:56:32.822] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:56:32.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:11:0) after 1m0s
[14:57:32.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:11:0)
[14:57:32.918] Timer tick, asking Buildbucket for the build status
[14:57:33.088] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:57:33.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:12:0) after 1m0s
[14:58:33.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:12:0)
[14:58:33.160] Timer tick, asking Buildbucket for the build status
[14:58:33.274] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:58:33.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:13:0) after 1m0s
[14:59:33.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:13:0)
[14:59:33.342] Timer tick, asking Buildbucket for the build status
[14:59:33.426] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:59:33.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:14:0) after 1m0s
[15:00:33.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:14:0)
[15:00:33.462] Timer tick, asking Buildbucket for the build status
[15:00:33.746] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:00:33.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:15:0) after 1m0s
[15:01:33.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:15:0)
[15:01:33.764] Timer tick, asking Buildbucket for the build status
[15:01:33.961] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:01:33.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:16:0) after 1m0s
[15:02:33.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:16:0)
[15:02:33.979] Timer tick, asking Buildbucket for the build status
[15:02:34.421] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:02:34.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:17:0) after 1m0s
[15:03:34.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:17:0)
[15:03:34.553] Timer tick, asking Buildbucket for the build status
[15:03:34.663] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:03:34.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:18:0) after 1m0s
[15:04:34.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:18:0)
[15:04:34.694] Timer tick, asking Buildbucket for the build status
[15:04:34.930] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:04:34.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:19:0) after 1m0s
[15:05:34.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:19:0)
[15:05:34.953] Timer tick, asking Buildbucket for the build status
[15:05:35.084] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:05:35.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:20:0) after 1m0s
[15:06:35.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:20:0)
[15:06:35.139] Timer tick, asking Buildbucket for the build status
[15:06:35.316] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:06:35.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:21:0) after 1m0s
[15:07:35.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:21:0)
[15:07:35.347] Timer tick, asking Buildbucket for the build status
[15:07:35.486] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:07:35.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:22:0) after 1m0s
[15:08:35.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:22:0)
[15:08:35.490] Timer tick, asking Buildbucket for the build status
[15:08:35.723] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:08:35.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:23:0) after 1m0s
[15:09:35.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:23:0)
[15:09:35.742] Timer tick, asking Buildbucket for the build status
[15:09:35.843] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:09:35.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:24:0) after 1m0s
[15:10:35.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:24:0)
[15:10:35.863] Timer tick, asking Buildbucket for the build status
[15:10:35.964] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:10:35.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:25:0) after 1m0s
[15:11:35.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:25:0)
[15:11:35.985] Timer tick, asking Buildbucket for the build status
[15:11:36.209] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:11:36.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:26:0) after 1m0s
[15:12:36.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:26:0)
[15:12:36.198] Timer tick, asking Buildbucket for the build status
[15:12:36.379] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:12:36.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:27:0) after 1m0s
[15:13:36.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:27:0)
[15:13:36.411] Timer tick, asking Buildbucket for the build status
[15:13:36.525] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:13:36.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:28:0) after 1m0s
[15:14:36.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:28:0)
[15:14:36.577] Timer tick, asking Buildbucket for the build status
[15:14:36.679] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:14:36.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:29:0) after 1m0s
[15:15:36.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:29:0)
[15:15:36.731] Timer tick, asking Buildbucket for the build status
[15:15:37.152] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:15:37.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:30:0) after 1m0s
[15:16:37.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:30:0)
[15:16:37.173] Timer tick, asking Buildbucket for the build status
[15:16:37.254] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:16:37.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:31:0) after 1m0s
[15:17:37.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:31:0)
[15:17:37.297] Timer tick, asking Buildbucket for the build status
[15:17:37.616] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:17:37.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:32:0) after 1m0s
[15:18:37.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:32:0)
[15:18:37.638] Timer tick, asking Buildbucket for the build status
[15:18:37.725] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:18:37.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:33:0) after 1m0s
[15:19:37.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:33:0)
[15:19:37.753] Timer tick, asking Buildbucket for the build status
[15:19:37.843] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:19:37.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:34:0) after 1m0s
[15:20:37.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:34:0)
[15:20:37.906] Timer tick, asking Buildbucket for the build status
[15:20:38.042] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:20:38.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:35:0) after 1m0s
[15:21:39.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:35:0)
[15:21:39.633] Timer tick, asking Buildbucket for the build status
[15:21:39.777] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:21:39.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:36:0) after 1m0s
[15:22:39.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:36:0)
[15:22:39.900] Timer tick, asking Buildbucket for the build status
[15:22:40.052] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:22:40.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:37:0) after 1m0s
[15:23:40.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:37:0)
[15:23:40.185] Timer tick, asking Buildbucket for the build status
[15:23:42.071] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:23:42.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:38:0) after 1m0s
[15:24:42.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:38:0)
[15:24:42.103] Timer tick, asking Buildbucket for the build status
[15:24:42.288] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:24:42.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:39:0) after 1m0s
[15:25:42.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:39:0)
[15:25:42.316] Timer tick, asking Buildbucket for the build status
[15:25:42.409] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:25:42.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:40:0) after 1m0s
[15:26:42.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:40:0)
[15:26:42.479] Timer tick, asking Buildbucket for the build status
[15:26:42.549] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:26:42.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:41:0) after 1m0s
[15:27:42.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:41:0)
[15:27:42.567] Timer tick, asking Buildbucket for the build status
[15:27:42.684] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:27:42.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:42:0) after 1m0s
[15:28:42.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:42:0)
[15:28:42.708] Timer tick, asking Buildbucket for the build status
[15:28:42.780] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:28:42.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:43:0) after 1m0s
[15:29:42.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:43:0)
[15:29:42.816] Timer tick, asking Buildbucket for the build status
[15:29:45.465] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:29:45.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:44:0) after 1m0s
[15:30:45.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:44:0)
[15:30:45.485] Timer tick, asking Buildbucket for the build status
[15:30:45.841] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:30:45.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:45:0) after 1m0s
[15:31:45.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:45:0)
[15:31:45.880] Timer tick, asking Buildbucket for the build status
[15:31:45.978] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:31:45.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:46:0) after 1m0s
[15:32:45.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:46:0)
[15:32:45.998] Timer tick, asking Buildbucket for the build status
[15:32:46.243] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:32:46.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:47:0) after 1m0s
[15:33:46.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:47:0)
[15:33:46.225] Timer tick, asking Buildbucket for the build status
[15:33:46.306] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:33:46.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:48:0) after 1m0s
[15:34:46.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:48:0)
[15:34:46.327] Timer tick, asking Buildbucket for the build status
[15:34:46.423] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:34:46.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:49:0) after 1m0s
[15:35:46.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:49:0)
[15:35:46.445] Timer tick, asking Buildbucket for the build status
[15:35:47.521] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:35:47.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:50:0) after 1m0s
[15:36:47.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:50:0)
[15:36:47.541] Timer tick, asking Buildbucket for the build status
[15:36:47.654] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:36:47.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:51:0) after 1m0s
[15:37:47.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:51:0)
[15:37:47.656] Timer tick, asking Buildbucket for the build status
[15:37:47.857] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:37:47.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:52:0) after 1m0s
[15:38:47.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:52:0)
[15:38:47.911] Timer tick, asking Buildbucket for the build status
[15:38:48.102] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:38:48.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:53:0) after 1m0s
[15:39:48.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:53:0)
[15:39:48.169] Timer tick, asking Buildbucket for the build status
[15:39:48.251] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:39:48.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:54:0) after 1m0s
[15:40:48.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:54:0)
[15:40:48.271] Timer tick, asking Buildbucket for the build status
[15:40:48.357] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:40:48.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:55:0) after 1m0s
[15:41:48.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:55:0)
[15:41:48.449] Timer tick, asking Buildbucket for the build status
[15:41:48.622] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:41:48.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:56:0) after 1m0s
[15:42:48.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:56:0)
[15:42:48.657] Timer tick, asking Buildbucket for the build status
[15:42:49.007] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:42:49.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:57:0) after 1m0s
[15:43:49.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:57:0)
[15:43:49.028] Timer tick, asking Buildbucket for the build status
[15:43:49.193] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:43:49.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:58:0) after 1m0s
[15:44:49.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:58:0)
[15:44:49.216] Timer tick, asking Buildbucket for the build status
[15:44:49.284] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:44:49.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:59:0) after 1m0s
[15:45:49.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:59:0)
[15:45:49.306] Timer tick, asking Buildbucket for the build status
[15:45:49.412] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:45:49.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:60:0) after 1m0s
[15:46:49.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:60:0)
[15:46:49.430] Timer tick, asking Buildbucket for the build status
[15:46:49.573] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:46:49.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:61:0) after 1m0s
[15:47:49.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:61:0)
[15:47:49.690] Timer tick, asking Buildbucket for the build status
[15:47:49.878] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:47:49.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:62:0) after 1m0s
[15:48:49.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:62:0)
[15:48:49.903] Timer tick, asking Buildbucket for the build status
[15:48:50.380] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:48:50.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:63:0) after 1m0s
[15:49:50.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:63:0)
[15:49:50.400] Timer tick, asking Buildbucket for the build status
[15:49:50.489] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:49:50.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:64:0) after 1m0s
[15:50:50.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:64:0)
[15:50:50.515] Timer tick, asking Buildbucket for the build status
[15:50:50.651] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:50:50.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:65:0) after 1m0s
[15:51:50.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:65:0)
[15:51:50.763] Timer tick, asking Buildbucket for the build status
[15:51:50.856] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:51:50.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:66:0) after 1m0s
[15:52:50.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:66:0)
[15:52:50.934] Timer tick, asking Buildbucket for the build status
[15:52:51.115] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:52:51.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:67:0) after 1m0s
[15:53:51.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:67:0)
[15:53:51.152] Timer tick, asking Buildbucket for the build status
[15:53:51.266] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:53:51.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:68:0) after 1m0s
[15:54:51.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:68:0)
[15:54:51.292] Timer tick, asking Buildbucket for the build status
[15:54:51.399] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:54:51.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:69:0) after 1m0s
[15:55:51.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:69:0)
[15:55:51.426] Timer tick, asking Buildbucket for the build status
[15:55:51.565] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:55:51.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:70:0) after 1m0s
[15:56:51.598] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:70:0)
[15:56:51.598] Timer tick, asking Buildbucket for the build status
[15:56:51.683] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:56:51.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:71:0) after 1m0s
[15:57:51.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:71:0)
[15:57:51.703] Timer tick, asking Buildbucket for the build status
[15:57:51.828] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:57:51.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:72:0) after 1m0s
[15:58:51.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:72:0)
[15:58:51.897] Timer tick, asking Buildbucket for the build status
[15:58:52.164] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:58:52.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:73:0) after 1m0s
[15:59:52.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:73:0)
[15:59:52.317] Timer tick, asking Buildbucket for the build status
[15:59:52.384] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:59:52.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:74:0) after 1m0s
[16:00:52.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:74:0)
[16:00:52.404] Timer tick, asking Buildbucket for the build status
[16:00:52.847] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:00:52.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:75:0) after 1m0s
[16:01:52.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:75:0)
[16:01:52.966] Timer tick, asking Buildbucket for the build status
[16:01:53.066] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:01:53.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:76:0) after 1m0s
[16:02:53.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:76:0)
[16:02:53.096] Timer tick, asking Buildbucket for the build status
[16:02:53.238] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:02:53.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:77:0) after 1m0s
[16:03:53.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:77:0)
[16:03:53.428] Timer tick, asking Buildbucket for the build status
[16:03:53.537] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:03:53.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:78:0) after 1m0s
[16:04:53.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:78:0)
[16:04:53.569] Timer tick, asking Buildbucket for the build status
[16:04:53.665] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:04:53.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:79:0) after 1m0s
[16:05:53.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:79:0)
[16:05:53.836] Timer tick, asking Buildbucket for the build status
[16:05:53.916] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:05:53.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:80:0) after 1m0s
[16:06:53.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:80:0)
[16:06:53.960] Timer tick, asking Buildbucket for the build status
[16:06:54.095] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:06:54.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:81:0) after 1m0s
[16:07:54.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:81:0)
[16:07:54.115] Timer tick, asking Buildbucket for the build status
[16:07:54.356] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:07:54.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:82:0) after 1m0s
[16:08:54.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:82:0)
[16:08:54.388] Timer tick, asking Buildbucket for the build status
[16:08:54.482] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:08:54.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:83:0) after 1m0s
[16:09:54.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:83:0)
[16:09:54.539] Timer tick, asking Buildbucket for the build status
[16:09:54.779] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:09:54.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:84:0) after 1m0s
[16:10:54.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:84:0)
[16:10:54.942] Timer tick, asking Buildbucket for the build status
[16:10:55.048] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:10:55.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:85:0) after 1m0s
[16:11:55.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:85:0)
[16:11:55.069] Timer tick, asking Buildbucket for the build status
[16:11:55.209] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:11:55.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:86:0) after 1m0s
[16:12:55.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:86:0)
[16:12:55.230] Timer tick, asking Buildbucket for the build status
[16:12:55.505] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:12:55.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:87:0) after 1m0s
[16:13:55.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:87:0)
[16:13:55.477] Timer tick, asking Buildbucket for the build status
[16:13:55.658] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:13:55.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:88:0) after 1m0s
[16:14:55.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:88:0)
[16:14:55.756] Timer tick, asking Buildbucket for the build status
[16:14:55.838] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:14:55.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:89:0) after 1m0s
[16:15:55.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:89:0)
[16:15:55.963] Timer tick, asking Buildbucket for the build status
[16:15:56.053] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:15:56.053] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:90:0) after 1m0s
[16:16:56.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:90:0)
[16:16:56.108] Timer tick, asking Buildbucket for the build status
[16:16:56.532] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:16:56.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:91:0) after 1m0s
[16:17:56.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:91:0)
[16:17:56.605] Timer tick, asking Buildbucket for the build status
[16:17:56.703] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:17:56.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:92:0) after 1m0s
[16:18:56.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:92:0)
[16:18:56.856] Timer tick, asking Buildbucket for the build status
[16:18:57.242] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:18:57.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:93:0) after 1m0s
[16:19:57.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:93:0)
[16:19:57.455] Timer tick, asking Buildbucket for the build status
[16:19:57.534] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:19:57.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:94:0) after 1m0s
[16:20:57.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:94:0)
[16:20:57.765] Timer tick, asking Buildbucket for the build status
[16:20:57.861] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:20:57.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:95:0) after 1m0s
[16:21:57.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:95:0)
[16:21:57.994] Timer tick, asking Buildbucket for the build status
[16:21:58.216] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:21:58.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:96:0) after 1m0s
[16:22:58.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:96:0)
[16:22:58.253] Timer tick, asking Buildbucket for the build status
[16:22:58.398] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:22:58.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:97:0) after 1m0s
[16:23:58.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:97:0)
[16:23:58.546] Timer tick, asking Buildbucket for the build status
[16:23:58.626] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:23:58.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:98:0) after 1m0s
[16:24:58.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:98:0)
[16:24:58.805] Timer tick, asking Buildbucket for the build status
[16:24:58.901] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:24:58.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:99:0) after 1m0s
[16:25:58.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:99:0)
[16:25:58.973] Timer tick, asking Buildbucket for the build status
[16:25:59.042] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:25:59.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:100:0) after 1m0s
[16:26:59.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:100:0)
[16:26:59.099] Timer tick, asking Buildbucket for the build status
[16:26:59.190] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:26:59.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:101:0) after 1m0s
[16:27:59.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:101:0)
[16:27:59.209] Timer tick, asking Buildbucket for the build status
[16:27:59.481] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:27:59.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:102:0) after 1m0s
[16:28:59.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:102:0)
[16:28:59.515] Timer tick, asking Buildbucket for the build status
[16:28:59.784] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:28:59.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:103:0) after 1m0s
[16:29:59.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:103:0)
[16:29:59.757] Timer tick, asking Buildbucket for the build status
[16:29:59.961] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:29:59.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:104:0) after 1m0s
[16:31:00.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:104:0)
[16:31:00.126] Timer tick, asking Buildbucket for the build status
[16:31:00.247] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:31:00.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:105:0) after 1m0s
[16:32:00.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:105:0)
[16:32:00.258] Timer tick, asking Buildbucket for the build status
[16:32:00.350] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:32:00.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:106:0) after 1m0s
[16:33:00.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:106:0)
[16:33:00.351] Timer tick, asking Buildbucket for the build status
[16:33:00.459] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:33:00.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:107:0) after 1m0s
[16:34:00.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:107:0)
[16:34:00.472] Timer tick, asking Buildbucket for the build status
[16:34:00.571] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:34:00.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:108:0) after 1m0s
[16:35:00.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:108:0)
[16:35:00.693] Timer tick, asking Buildbucket for the build status
[16:35:00.786] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:35:00.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:109:0) after 1m0s
[16:36:02.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:109:0)
[16:36:02.064] Timer tick, asking Buildbucket for the build status
[16:36:02.266] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:36:02.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:110:0) after 1m0s
[16:37:02.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:110:0)
[16:37:02.311] Timer tick, asking Buildbucket for the build status
[16:37:02.400] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:37:02.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:111:0) after 1m0s
[16:38:02.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:111:0)
[16:38:02.437] Timer tick, asking Buildbucket for the build status
[16:38:02.891] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:38:02.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:112:0) after 1m0s
[16:39:03.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:112:0)
[16:39:03.116] Timer tick, asking Buildbucket for the build status
[16:39:03.231] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:39:03.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:113:0) after 1m0s
[16:40:03.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:113:0)
[16:40:03.243] Timer tick, asking Buildbucket for the build status
[16:40:03.385] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:40:03.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:114:0) after 1m0s
[16:41:03.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:114:0)
[16:41:03.411] Timer tick, asking Buildbucket for the build status
[16:41:03.683] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:41:03.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:115:0) after 1m0s
[16:42:03.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:115:0)
[16:42:03.702] Timer tick, asking Buildbucket for the build status
[16:42:03.846] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:42:03.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:116:0) after 1m0s
[16:43:03.926] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:116:0)
[16:43:03.926] Timer tick, asking Buildbucket for the build status
[16:43:04.189] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:43:04.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:117:0) after 1m0s
[16:44:04.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:117:0)
[16:44:04.226] Timer tick, asking Buildbucket for the build status
[16:44:04.309] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:44:04.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:118:0) after 1m0s
[16:45:04.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:118:0)
[16:45:04.412] Timer tick, asking Buildbucket for the build status
[16:45:05.194] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:45:05.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:119:0) after 1m0s
[16:46:05.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:119:0)
[16:46:05.259] Timer tick, asking Buildbucket for the build status
[16:46:05.347] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:46:05.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:120:0) after 1m0s
[16:47:05.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:120:0)
[16:47:05.339] Timer tick, asking Buildbucket for the build status
[16:47:05.455] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:47:05.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:121:0) after 1m0s
[16:48:05.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:121:0)
[16:48:05.477] Timer tick, asking Buildbucket for the build status
[16:48:05.721] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:48:05.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:122:0) after 1m0s
[16:49:05.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:122:0)
[16:49:05.743] Timer tick, asking Buildbucket for the build status
[16:49:05.855] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:49:05.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:123:0) after 1m0s
[16:50:05.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:123:0)
[16:50:05.876] Timer tick, asking Buildbucket for the build status
[16:50:06.020] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:50:06.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:124:0) after 1m0s
[16:51:06.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:124:0)
[16:51:06.087] Timer tick, asking Buildbucket for the build status
[16:51:06.178] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:51:06.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:125:0) after 1m0s
[16:52:06.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:125:0)
[16:52:06.188] Timer tick, asking Buildbucket for the build status
[16:52:06.286] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:52:06.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:126:0) after 1m0s
[16:53:06.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:126:0)
[16:53:06.309] Timer tick, asking Buildbucket for the build status
[16:53:06.448] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:53:06.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:127:0) after 1m0s
[16:54:06.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:127:0)
[16:54:06.468] Timer tick, asking Buildbucket for the build status
[16:54:06.564] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:54:06.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:128:0) after 1m0s
[16:55:06.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:128:0)
[16:55:06.730] Timer tick, asking Buildbucket for the build status
[16:55:07.111] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:55:07.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:129:0) after 1m0s
[16:56:07.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:129:0)
[16:56:07.145] Timer tick, asking Buildbucket for the build status
[16:56:07.242] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:56:07.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:130:0) after 1m0s
[16:57:07.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:130:0)
[16:57:07.264] Timer tick, asking Buildbucket for the build status
[16:57:07.351] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:57:07.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:131:0) after 1m0s
[16:58:07.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:131:0)
[16:58:07.387] Timer tick, asking Buildbucket for the build status
[16:58:07.614] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:58:07.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:132:0) after 1m0s
[16:59:07.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:132:0)
[16:59:07.688] Timer tick, asking Buildbucket for the build status
[16:59:07.762] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:59:07.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:133:0) after 1m0s
[17:00:07.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:133:0)
[17:00:07.798] Timer tick, asking Buildbucket for the build status
[17:00:07.899] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:00:07.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:134:0) after 1m0s
[17:01:07.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:134:0)
[17:01:07.930] Timer tick, asking Buildbucket for the build status
[17:01:08.043] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:01:08.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:135:0) after 1m0s
[17:02:08.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:135:0)
[17:02:08.193] Timer tick, asking Buildbucket for the build status
[17:02:08.282] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:02:08.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:136:0) after 1m0s
[17:03:08.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:136:0)
[17:03:08.329] Timer tick, asking Buildbucket for the build status
[17:03:10.317] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:03:10.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:137:0) after 1m0s
[17:04:10.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:137:0)
[17:04:10.453] Timer tick, asking Buildbucket for the build status
[17:04:10.550] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:04:10.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:138:0) after 1m0s
[17:05:10.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:138:0)
[17:05:10.629] Timer tick, asking Buildbucket for the build status
[17:05:10.728] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:05:10.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:139:0) after 1m0s
[17:06:10.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:139:0)
[17:06:10.786] Timer tick, asking Buildbucket for the build status
[17:06:12.165] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:06:12.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:140:0) after 1m0s
[17:07:12.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:140:0)
[17:07:12.279] Timer tick, asking Buildbucket for the build status
[17:07:12.367] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:07:12.368] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:141:0) after 1m0s
[17:08:12.399] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:141:0)
[17:08:12.399] Timer tick, asking Buildbucket for the build status
[17:08:12.513] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:08:12.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:142:0) after 1m0s
[17:09:12.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:142:0)
[17:09:12.595] Timer tick, asking Buildbucket for the build status
[17:09:12.688] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:09:12.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:143:0) after 1m0s
[17:10:12.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:143:0)
[17:10:12.697] Timer tick, asking Buildbucket for the build status
[17:10:12.801] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:10:12.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:144:0) after 1m0s
[17:11:12.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:144:0)
[17:11:12.856] Timer tick, asking Buildbucket for the build status
[17:11:13.129] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:11:13.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:145:0) after 1m0s
[17:12:13.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:145:0)
[17:12:13.124] Timer tick, asking Buildbucket for the build status
[17:12:13.491] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:12:13.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:146:0) after 1m0s
[17:13:13.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:146:0)
[17:13:13.596] Timer tick, asking Buildbucket for the build status
[17:13:13.686] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:13:13.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:147:0) after 1m0s
[17:14:13.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:147:0)
[17:14:13.707] Timer tick, asking Buildbucket for the build status
[17:14:13.833] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:14:13.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:148:0) after 1m0s
[17:15:13.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:148:0)
[17:15:13.862] Timer tick, asking Buildbucket for the build status
[17:15:14.133] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:15:14.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:149:0) after 1m0s
[17:16:14.140] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:149:0)
[17:16:14.140] Timer tick, asking Buildbucket for the build status
[17:16:14.448] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:16:14.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:150:0) after 1m0s
[17:17:14.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:150:0)
[17:17:14.533] Timer tick, asking Buildbucket for the build status
[17:17:14.630] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:17:14.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:151:0) after 1m0s
[17:18:14.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:151:0)
[17:18:14.697] Timer tick, asking Buildbucket for the build status
[17:18:14.858] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:18:14.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:152:0) after 1m0s
[17:19:14.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:152:0)
[17:19:14.946] Timer tick, asking Buildbucket for the build status
[17:19:15.093] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:19:15.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:153:0) after 1m0s
[17:20:15.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:153:0)
[17:20:15.116] Timer tick, asking Buildbucket for the build status
[17:20:15.200] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:20:15.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:154:0) after 1m0s
[17:21:15.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:154:0)
[17:21:15.415] Timer tick, asking Buildbucket for the build status
[17:21:15.505] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:21:15.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:155:0) after 1m0s
[17:22:15.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:155:0)
[17:22:15.860] Timer tick, asking Buildbucket for the build status
[17:22:15.936] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:22:15.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:156:0) after 1m0s
[17:23:16.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:156:0)
[17:23:16.302] Timer tick, asking Buildbucket for the build status
[17:23:16.737] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:23:16.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:157:0) after 1m0s
[17:24:17.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:157:0)
[17:24:17.034] Timer tick, asking Buildbucket for the build status
[17:24:17.569] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:24:17.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:158:0) after 1m0s
[17:25:17.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:158:0)
[17:25:17.872] Timer tick, asking Buildbucket for the build status
[17:25:18.123] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:25:18.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:159:0) after 1m0s
[17:26:18.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:159:0)
[17:26:18.454] Timer tick, asking Buildbucket for the build status
[17:26:18.722] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:26:18.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:160:0) after 1m0s
[17:27:18.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:160:0)
[17:27:18.951] Timer tick, asking Buildbucket for the build status
[17:27:19.082] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:27:19.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:161:0) after 1m0s
[17:28:19.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:161:0)
[17:28:19.264] Timer tick, asking Buildbucket for the build status
[17:28:19.483] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:28:19.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:162:0) after 1m0s
[17:29:19.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:162:0)
[17:29:19.499] Timer tick, asking Buildbucket for the build status
[17:29:19.570] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:29:19.570] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:163:0) after 1m0s
[17:30:19.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:163:0)
[17:30:19.768] Timer tick, asking Buildbucket for the build status
[17:30:20.839] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:30:20.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:164:0) after 1m0s
[17:31:21.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:164:0)
[17:31:21.115] Timer tick, asking Buildbucket for the build status
[17:31:23.419] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:31:23.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:165:0) after 1m0s
[17:32:23.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:165:0)
[17:32:23.565] Timer tick, asking Buildbucket for the build status
[17:32:23.638] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:32:23.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:166:0) after 1m0s
[17:33:23.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:166:0)
[17:33:23.764] Timer tick, asking Buildbucket for the build status
[17:33:24.009] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:33:24.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:167:0) after 1m0s
[17:34:24.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:167:0)
[17:34:24.188] Timer tick, asking Buildbucket for the build status
[17:34:24.258] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:34:24.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:168:0) after 1m0s
[17:35:24.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:168:0)
[17:35:24.329] Timer tick, asking Buildbucket for the build status
[17:35:24.400] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:35:24.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:169:0) after 1m0s
[17:36:24.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:169:0)
[17:36:24.414] Timer tick, asking Buildbucket for the build status
[17:36:24.517] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:36:24.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:170:0) after 1m0s
[17:37:24.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:170:0)
[17:37:24.570] Timer tick, asking Buildbucket for the build status
[17:37:24.662] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:37:24.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:171:0) after 1m0s
[17:38:24.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:171:0)
[17:38:24.693] Timer tick, asking Buildbucket for the build status
[17:38:25.760] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:38:25.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:172:0) after 1m0s
[17:39:25.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:172:0)
[17:39:25.828] Timer tick, asking Buildbucket for the build status
[17:39:25.970] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:39:25.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:173:0) after 1m0s
[17:40:26.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:173:0)
[17:40:26.049] Timer tick, asking Buildbucket for the build status
[17:40:26.444] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:40:26.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:174:0) after 1m0s
[17:41:26.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:174:0)
[17:41:26.482] Timer tick, asking Buildbucket for the build status
[17:41:26.737] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:41:26.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:175:0) after 1m0s
[17:42:26.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:175:0)
[17:42:26.765] Timer tick, asking Buildbucket for the build status
[17:42:26.851] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:42:26.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:176:0) after 1m0s
[17:43:26.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:176:0)
[17:43:26.879] Timer tick, asking Buildbucket for the build status
[17:43:27.033] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:43:27.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:177:0) after 1m0s
[17:44:27.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:177:0)
[17:44:27.143] Timer tick, asking Buildbucket for the build status
[17:44:27.366] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:44:27.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:178:0) after 1m0s
[17:45:27.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:178:0)
[17:45:27.430] Timer tick, asking Buildbucket for the build status
[17:45:27.526] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:45:27.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:179:0) after 1m0s
[17:46:27.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:179:0)
[17:46:27.619] Timer tick, asking Buildbucket for the build status
[17:46:27.696] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:46:27.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:180:0) after 1m0s
[17:47:27.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:180:0)
[17:47:27.780] Timer tick, asking Buildbucket for the build status
[17:47:28.025] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:47:28.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:181:0) after 1m0s
[17:48:28.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:181:0)
[17:48:28.048] Timer tick, asking Buildbucket for the build status
[17:48:28.194] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:48:28.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:182:0) after 1m0s
[17:49:28.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:182:0)
[17:49:28.316] Timer tick, asking Buildbucket for the build status
[17:49:28.388] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:49:28.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:183:0) after 1m0s
[17:50:28.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:183:0)
[17:50:28.506] Timer tick, asking Buildbucket for the build status
[17:50:28.578] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:50:28.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:184:0) after 1m0s
[17:51:28.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:184:0)
[17:51:28.684] Timer tick, asking Buildbucket for the build status
[17:51:29.058] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:51:29.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:185:0) after 1m0s
[17:52:29.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:185:0)
[17:52:29.117] Timer tick, asking Buildbucket for the build status
[17:52:29.223] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:52:29.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:186:0) after 1m0s
[17:53:29.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:186:0)
[17:53:29.299] Timer tick, asking Buildbucket for the build status
[17:53:29.672] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:53:29.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:187:0) after 1m0s
[17:54:29.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:187:0)
[17:54:29.744] Timer tick, asking Buildbucket for the build status
[17:54:29.975] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:54:29.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:188:0) after 1m0s
[17:55:30.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:188:0)
[17:55:30.004] Timer tick, asking Buildbucket for the build status
[17:55:30.099] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:55:30.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:189:0) after 1m0s
[17:56:30.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:189:0)
[17:56:30.188] Timer tick, asking Buildbucket for the build status
[17:56:30.316] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:56:30.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:190:0) after 1m0s
[17:57:30.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:190:0)
[17:57:30.398] Timer tick, asking Buildbucket for the build status
[17:57:30.780] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:57:30.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:191:0) after 1m0s
[17:58:30.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:191:0)
[17:58:30.831] Timer tick, asking Buildbucket for the build status
[17:58:31.097] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:58:31.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:192:0) after 1m0s
[17:59:31.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:192:0)
[17:59:31.217] Timer tick, asking Buildbucket for the build status
[17:59:31.413] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:59:31.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:193:0) after 1m0s
[18:00:31.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:193:0)
[18:00:31.404] Timer tick, asking Buildbucket for the build status
[18:00:31.577] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:00:31.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:194:0) after 1m0s
[18:01:31.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:194:0)
[18:01:31.602] Timer tick, asking Buildbucket for the build status
[18:01:31.716] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:01:31.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:195:0) after 1m0s
[18:02:31.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:195:0)
[18:02:31.742] Timer tick, asking Buildbucket for the build status
[18:02:32.145] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:02:32.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:196:0) after 1m0s
[18:03:32.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:196:0)
[18:03:32.283] Timer tick, asking Buildbucket for the build status
[18:03:32.477] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:03:32.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:197:0) after 1m0s
[18:04:32.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:197:0)
[18:04:32.503] Timer tick, asking Buildbucket for the build status
[18:04:32.888] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:04:32.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:198:0) after 1m0s
[18:05:32.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:198:0)
[18:05:32.922] Timer tick, asking Buildbucket for the build status
[18:05:33.022] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:05:33.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:199:0) after 1m0s
[18:06:33.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:199:0)
[18:06:33.048] Timer tick, asking Buildbucket for the build status
[18:06:33.201] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:06:33.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:200:0) after 1m0s
[18:07:33.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:200:0)
[18:07:33.176] Timer tick, asking Buildbucket for the build status
[18:07:33.284] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:07:33.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:201:0) after 1m0s
[18:08:33.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:201:0)
[18:08:33.338] Timer tick, asking Buildbucket for the build status
[18:08:33.546] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:08:33.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:202:0) after 1m0s
[18:09:33.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:202:0)
[18:09:33.572] Timer tick, asking Buildbucket for the build status
[18:09:33.689] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:09:33.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:203:0) after 1m0s
[18:10:33.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:203:0)
[18:10:33.732] Timer tick, asking Buildbucket for the build status
[18:10:33.853] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:10:33.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:204:0) after 1m0s
[18:11:33.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:204:0)
[18:11:33.879] Timer tick, asking Buildbucket for the build status
[18:11:33.989] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:11:33.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:205:0) after 1m0s
[18:12:34.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:205:0)
[18:12:34.048] Timer tick, asking Buildbucket for the build status
[18:12:34.291] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:12:34.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:206:0) after 1m0s
[18:13:34.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:206:0)
[18:13:34.307] Timer tick, asking Buildbucket for the build status
[18:13:34.619] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:13:34.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:207:0) after 1m0s
[18:14:34.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:207:0)
[18:14:34.647] Timer tick, asking Buildbucket for the build status
[18:14:34.757] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:14:34.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:208:0) after 1m0s
[18:15:34.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:208:0)
[18:15:34.881] Timer tick, asking Buildbucket for the build status
[18:15:35.276] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:15:35.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:209:0) after 1m0s
[18:16:35.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:209:0)
[18:16:35.301] Timer tick, asking Buildbucket for the build status
[18:16:35.392] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:16:35.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:210:0) after 1m0s
[18:17:35.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:210:0)
[18:17:35.376] Timer tick, asking Buildbucket for the build status
[18:17:35.470] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:17:35.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:211:0) after 1m0s
[18:18:35.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:211:0)
[18:18:35.582] Timer tick, asking Buildbucket for the build status
[18:18:36.162] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:18:36.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:212:0) after 1m0s
[18:19:36.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:212:0)
[18:19:36.199] Timer tick, asking Buildbucket for the build status
[18:19:36.294] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:19:36.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:213:0) after 1m0s
[18:20:36.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:213:0)
[18:20:36.316] Timer tick, asking Buildbucket for the build status
[18:20:36.585] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:20:36.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:214:0) after 1m0s
[18:21:36.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:214:0)
[18:21:36.573] Timer tick, asking Buildbucket for the build status
[18:21:36.655] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:21:36.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:215:0) after 1m0s
[18:22:36.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:215:0)
[18:22:36.681] Timer tick, asking Buildbucket for the build status
[18:22:36.889] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:22:36.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:216:0) after 1m0s
[18:23:36.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:216:0)
[18:23:36.933] Timer tick, asking Buildbucket for the build status
[18:23:37.779] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:23:37.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:217:0) after 1m0s
[18:24:37.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:217:0)
[18:24:37.841] Timer tick, asking Buildbucket for the build status
[18:24:37.922] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:24:37.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:218:0) after 1m0s
[18:25:38.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:218:0)
[18:25:38.008] Timer tick, asking Buildbucket for the build status
[18:25:39.540] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:25:39.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:219:0) after 1m0s
[18:26:39.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:219:0)
[18:26:39.689] Timer tick, asking Buildbucket for the build status
[18:26:40.164] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:26:40.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:220:0) after 1m0s
[18:27:40.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:220:0)
[18:27:40.255] Timer tick, asking Buildbucket for the build status
[18:27:40.358] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:27:40.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:221:0) after 1m0s
[18:28:40.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:221:0)
[18:28:40.383] Timer tick, asking Buildbucket for the build status
[18:28:42.141] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:28:42.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:222:0) after 1m0s
[18:29:42.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:222:0)
[18:29:42.227] Timer tick, asking Buildbucket for the build status
[18:29:42.317] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:29:42.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:223:0) after 1m0s
[18:30:42.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:223:0)
[18:30:42.379] Timer tick, asking Buildbucket for the build status
[18:30:42.504] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:30:42.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:224:0) after 1m0s
[18:31:42.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:224:0)
[18:31:42.551] Timer tick, asking Buildbucket for the build status
[18:31:42.786] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:31:42.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:225:0) after 1m0s
[18:32:42.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:225:0)
[18:32:42.916] Timer tick, asking Buildbucket for the build status
[18:32:42.995] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:32:42.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:226:0) after 1m0s
[18:33:43.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:226:0)
[18:33:43.128] Timer tick, asking Buildbucket for the build status
[18:33:43.236] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:33:43.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:227:0) after 1m0s
[18:34:43.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:227:0)
[18:34:43.247] Timer tick, asking Buildbucket for the build status
[18:34:43.657] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:34:43.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:228:0) after 1m0s
[18:35:43.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:228:0)
[18:35:43.786] Timer tick, asking Buildbucket for the build status
[18:35:43.895] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:35:43.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:229:0) after 1m0s
[18:36:43.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:229:0)
[18:36:43.921] Timer tick, asking Buildbucket for the build status
[18:36:44.059] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:36:44.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:230:0) after 1m0s
[18:37:44.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:230:0)
[18:37:44.093] Timer tick, asking Buildbucket for the build status
[18:37:44.343] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:37:44.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:231:0) after 1m0s
[18:38:44.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:231:0)
[18:38:44.461] Timer tick, asking Buildbucket for the build status
[18:38:46.138] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:38:46.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:232:0) after 1m0s
[18:39:46.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:232:0)
[18:39:46.128] Timer tick, asking Buildbucket for the build status
[18:39:46.315] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:39:46.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:233:0) after 1m0s
[18:40:46.305] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:233:0)
[18:40:46.305] Timer tick, asking Buildbucket for the build status
[18:40:46.416] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:40:46.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:234:0) after 1m0s
[18:41:46.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:234:0)
[18:41:46.487] Timer tick, asking Buildbucket for the build status
[18:41:46.608] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:41:46.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:235:0) after 1m0s
[18:42:46.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:235:0)
[18:42:46.668] Timer tick, asking Buildbucket for the build status
[18:42:46.771] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:42:46.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:236:0) after 1m0s
[18:43:46.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:236:0)
[18:43:46.797] Timer tick, asking Buildbucket for the build status
[18:43:46.906] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:43:46.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:237:0) after 1m0s
[18:44:46.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:237:0)
[18:44:46.954] Timer tick, asking Buildbucket for the build status
[18:44:47.039] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:44:47.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:238:0) after 1m0s
[18:45:47.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:238:0)
[18:45:47.183] Timer tick, asking Buildbucket for the build status
[18:45:47.355] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:45:47.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:239:0) after 1m0s
[18:46:47.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:239:0)
[18:46:47.378] Timer tick, asking Buildbucket for the build status
[18:46:47.515] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:46:47.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:240:0) after 1m0s
[18:47:47.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:240:0)
[18:47:47.610] Timer tick, asking Buildbucket for the build status
[18:47:47.852] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:47:47.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:241:0) after 1m0s
[18:48:47.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:241:0)
[18:48:47.877] Timer tick, asking Buildbucket for the build status
[18:48:48.071] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:48:48.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:242:0) after 1m0s
[18:49:48.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:242:0)
[18:49:48.197] Timer tick, asking Buildbucket for the build status
[18:49:48.284] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:49:48.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:243:0) after 1m0s
[18:50:48.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:243:0)
[18:50:48.419] Timer tick, asking Buildbucket for the build status
[18:50:48.509] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:50:48.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:244:0) after 1m0s
[18:51:48.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:244:0)
[18:51:48.584] Timer tick, asking Buildbucket for the build status
[18:51:48.680] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:51:48.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:245:0) after 1m0s
[18:52:48.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:245:0)
[18:52:48.784] Timer tick, asking Buildbucket for the build status
[18:52:49.055] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:52:49.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:246:0) after 1m0s
[18:53:49.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:246:0)
[18:53:49.065] Timer tick, asking Buildbucket for the build status
[18:53:49.412] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:53:49.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:247:0) after 1m0s
[18:54:49.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:247:0)
[18:54:49.497] Timer tick, asking Buildbucket for the build status
[18:54:50.898] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:54:50.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:248:0) after 1m0s
[18:55:50.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:248:0)
[18:55:50.981] Timer tick, asking Buildbucket for the build status
[18:55:51.064] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:55:51.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:249:0) after 1m0s
[18:56:51.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:249:0)
[18:56:51.098] Timer tick, asking Buildbucket for the build status
[18:56:51.203] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:56:51.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:250:0) after 1m0s
[18:57:51.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:250:0)
[18:57:51.318] Timer tick, asking Buildbucket for the build status
[18:57:51.534] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:57:51.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:251:0) after 1m0s
[18:58:51.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:251:0)
[18:58:51.594] Timer tick, asking Buildbucket for the build status
[18:58:55.514] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:58:55.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:252:0) after 1m0s
[18:59:55.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:252:0)
[18:59:55.523] Timer tick, asking Buildbucket for the build status
[18:59:56.335] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:59:56.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:253:0) after 1m0s
[19:00:56.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:253:0)
[19:00:56.436] Timer tick, asking Buildbucket for the build status
[19:00:56.546] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:00:56.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:254:0) after 1m0s
[19:01:56.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:254:0)
[19:01:56.581] Timer tick, asking Buildbucket for the build status
[19:01:56.681] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:01:56.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:255:0) after 1m0s
[19:02:56.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:255:0)
[19:02:56.736] Timer tick, asking Buildbucket for the build status
[19:02:56.843] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:02:56.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:256:0) after 1m0s
[19:03:56.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:256:0)
[19:03:56.974] Timer tick, asking Buildbucket for the build status
[19:03:57.148] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:57.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:257:0) after 1m0s
[19:04:57.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:257:0)
[19:04:57.172] Timer tick, asking Buildbucket for the build status
[19:04:57.531] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:04:57.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:258:0) after 1m0s
[19:05:57.630] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:258:0)
[19:05:57.630] Timer tick, asking Buildbucket for the build status
[19:05:57.711] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:05:57.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:259:0) after 1m0s
[19:06:57.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:259:0)
[19:06:57.782] Timer tick, asking Buildbucket for the build status
[19:06:57.867] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:57.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:260:0) after 1m0s
[19:07:57.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:260:0)
[19:07:57.982] Timer tick, asking Buildbucket for the build status
[19:07:58.086] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:07:58.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:261:0) after 1m0s
[19:08:58.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:261:0)
[19:08:58.164] Timer tick, asking Buildbucket for the build status
[19:08:58.266] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:08:58.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:262:0) after 1m0s
[19:09:58.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:262:0)
[19:09:58.490] Timer tick, asking Buildbucket for the build status
[19:09:58.731] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:09:58.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:263:0) after 1m0s
[19:10:58.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:263:0)
[19:10:58.966] Timer tick, asking Buildbucket for the build status
[19:10:59.141] Build 8867360719750165264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:10:59.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:264:0) after 1m0s
[19:11:29.510] Received PubSub notification, asking Buildbucket for the build status
[19:11:29.764] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:59.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:264:0)
[19:11:59.164] Timer tick, asking Buildbucket for the build status
[19:11:59.268] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:59.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:266:0) after 1m0s
[19:12:59.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:266:0)
[19:12:59.555] Timer tick, asking Buildbucket for the build status
[19:12:59.716] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:59.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:267:0) after 1m0s
[19:13:59.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:267:0)
[19:13:59.745] Timer tick, asking Buildbucket for the build status
[19:13:59.980] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:59.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:268:0) after 1m0s
[19:15:00.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:268:0)
[19:15:00.061] Timer tick, asking Buildbucket for the build status
[19:15:00.206] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:00.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:269:0) after 1m0s
[19:16:00.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:269:0)
[19:16:00.286] Timer tick, asking Buildbucket for the build status
[19:16:01.063] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:01.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:270:0) after 1m0s
[19:17:01.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:270:0)
[19:17:01.724] Timer tick, asking Buildbucket for the build status
[19:17:01.992] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:01.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:271:0) after 1m0s
[19:18:02.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:271:0)
[19:18:02.210] Timer tick, asking Buildbucket for the build status
[19:18:02.297] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:02.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:272:0) after 1m0s
[19:19:03.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:272:0)
[19:19:03.469] Timer tick, asking Buildbucket for the build status
[19:19:03.583] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:03.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:273:0) after 1m0s
[19:20:03.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:273:0)
[19:20:03.656] Timer tick, asking Buildbucket for the build status
[19:20:03.897] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:03.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:274:0) after 1m0s
[19:21:03.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:274:0)
[19:21:03.961] Timer tick, asking Buildbucket for the build status
[19:21:04.066] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:04.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:275:0) after 1m0s
[19:22:04.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:275:0)
[19:22:04.190] Timer tick, asking Buildbucket for the build status
[19:22:04.538] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:04.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:276:0) after 1m0s
[19:23:04.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:276:0)
[19:23:04.548] Timer tick, asking Buildbucket for the build status
[19:23:04.660] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:04.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:277:0) after 1m0s
[19:24:04.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:277:0)
[19:24:04.820] Timer tick, asking Buildbucket for the build status
[19:24:04.953] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:04.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:278:0) after 1m0s
[19:25:05.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:278:0)
[19:25:05.583] Timer tick, asking Buildbucket for the build status
[19:25:05.797] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:05.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:279:0) after 1m0s
[19:26:05.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:279:0)
[19:26:05.922] Timer tick, asking Buildbucket for the build status
[19:26:06.213] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:06.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:280:0) after 1m0s
[19:27:06.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:280:0)
[19:27:06.216] Timer tick, asking Buildbucket for the build status
[19:27:06.427] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:06.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:281:0) after 1m0s
[19:28:06.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:281:0)
[19:28:06.543] Timer tick, asking Buildbucket for the build status
[19:28:06.821] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:06.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:282:0) after 1m0s
[19:29:07.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:282:0)
[19:29:07.333] Timer tick, asking Buildbucket for the build status
[19:29:07.626] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:07.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:283:0) after 1m0s
[19:30:07.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:283:0)
[19:30:07.813] Timer tick, asking Buildbucket for the build status
[19:30:08.023] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:08.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:284:0) after 1m0s
[19:31:08.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:284:0)
[19:31:08.484] Timer tick, asking Buildbucket for the build status
[19:31:08.617] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:08.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:285:0) after 1m0s
[19:32:08.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:285:0)
[19:32:08.764] Timer tick, asking Buildbucket for the build status
[19:32:08.971] Build 8867360719750165264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:08.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032790781713404928:286:0) after 1m0s
[19:32:46.251] Received PubSub notification, asking Buildbucket for the build status
[19:32:46.357] Build 8867360719750165264: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[19:32:46.357] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1601839965974870",
    "created_by": "project:infra",
    "created_ts": "1601822849472632",
    "failure_reason": "BUILD_FAILURE",
    "id": "8867360719750165264",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4280.5\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ea471987-959f-4adf-8be1-f83f848307c0\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4280.5\"}}",
    "project": "infra",
    "result": "FAILURE",
    "result_details_json": "{\"error\": {\"message\": \"Step('Bootstrap gn.') (retcode: 1)\"}, \"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_292036ca8cd0711903e829a3c5417e821d204af08fdef2e4b6d3affbee40eeb2_v2\", \"builder_4d1db109d30b9f0068cf0464722c703e05f788cd82e2d29876a9483818e7c333_v2\", \"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2\", \"builder_dbab9abe7188467828c33829af37b0f6a86a533613509fd8bbd879beea667f22_v2\", \"git\", \"goma_v2\", \"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-huxj\"], \"image\": [\"chrome-xenial-20091600-9ddf7e422ac\"], \"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\": [\"5564-e41b668\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}, \"ui\": {\"info\": \"Step('Bootstrap gn.') (retcode: 1)\"}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1601838688474370",
    "status": "COMPLETED",
    "status_changed_ts": "1601838689057114",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9032790781713404928",
      "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/8867360719750165264/+/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:4f0ce68782f41b10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1601839966059569",
    "url": "https://ci.chromium.org/b/8867360719750165264",
    "utcnow_ts": "1601839966338046"
  }
}
[19:32:46.358] Invocation finished in 4h45m18.14118954s with status FAILED