LUCI Scheduler :: infra :: Build From Tarball

Status: SUCCEEDED

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

Duration: 3 hours

Actions:

Definition (rev ef1333c7bf2cf95d15a0ce92acf83d24bcd6c5ac)

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

Incoming triggers

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

Incoming properties

{
  "version": "84.0.4114.3"
}

Incoming tags

parent_buildername:publish_tarball
user_agent:recipe

Debug log (UTC)

[10:58:03.059] New invocation is queued and will start shortly
[10:58:03.059] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[10:58:05.944] Starting the invocation (attempt 1)
[10:58:05.978] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:58:05.978] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:58:05.978] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9048206699831826176",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"84.0.4114.3\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"670623c1-f237-40bf-9276-536624281f05\",\"title\":\"publish_tarball/0\"}]},\"version\":\"84.0.4114.3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9048206699831826176",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[10:58:06.726] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "created_by": "project:infra",
    "created_ts": "1587121086142648",
    "id": "8882776635935871376",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4114.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"670623c1-f237-40bf-9276-536624281f05\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4114.3\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1587121086491015",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9048206699831826176",
      "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/8882776635935871376/+/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": "1587121086491213",
    "url": "https://ci.chromium.org/b/8882776635935871376",
    "utcnow_ts": "1587121086714450"
  }
}
[10:58:06.726] Task URL: https://ci.chromium.org/b/8882776635935871376
[10:58:06.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:2:0) after 1m0s
[10:59:06.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:2:0)
[10:59:06.840] Timer tick, asking Buildbucket for the build status
[10:59:07.335] Build 8882776635935871376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:59:07.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:3:0) after 1m0s
[11:00:07.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:3:0)
[11:00:07.357] Timer tick, asking Buildbucket for the build status
[11:00:07.477] Build 8882776635935871376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:00:07.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:4:0) after 1m0s
[11:01:07.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:4:0)
[11:01:07.789] Timer tick, asking Buildbucket for the build status
[11:01:08.068] Build 8882776635935871376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:01:08.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:5:0) after 1m0s
[11:02:08.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:5:0)
[11:02:08.223] Timer tick, asking Buildbucket for the build status
[11:02:08.341] Build 8882776635935871376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:02:08.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:6:0) after 1m0s
[11:03:08.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:6:0)
[11:03:08.621] Timer tick, asking Buildbucket for the build status
[11:03:09.078] Build 8882776635935871376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:03:09.078] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:7:0) after 1m0s
[11:04:09.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:7:0)
[11:04:09.172] Timer tick, asking Buildbucket for the build status
[11:04:09.331] Build 8882776635935871376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:04:09.331] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:8:0) after 1m0s
[11:05:09.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:8:0)
[11:05:09.468] Timer tick, asking Buildbucket for the build status
[11:05:09.602] Build 8882776635935871376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:05:09.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:9:0) after 1m0s
[11:06:09.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:9:0)
[11:06:09.752] Timer tick, asking Buildbucket for the build status
[11:06:09.908] Build 8882776635935871376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:06:09.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:10:0) after 1m0s
[11:07:09.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:10:0)
[11:07:09.965] Timer tick, asking Buildbucket for the build status
[11:07:10.404] Build 8882776635935871376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:07:10.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:11:0) after 1m0s
[11:08:10.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:11:0)
[11:08:10.619] Timer tick, asking Buildbucket for the build status
[11:08:10.947] Build 8882776635935871376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:08:10.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:12:0) after 1m0s
[11:09:11.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:12:0)
[11:09:11.055] Timer tick, asking Buildbucket for the build status
[11:09:11.219] Build 8882776635935871376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:09:11.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:13:0) after 1m0s
[11:10:11.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:13:0)
[11:10:11.322] Timer tick, asking Buildbucket for the build status
[11:10:11.509] Build 8882776635935871376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:10:11.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:14:0) after 1m0s
[11:11:11.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:14:0)
[11:11:11.593] Timer tick, asking Buildbucket for the build status
[11:11:11.802] Build 8882776635935871376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:11:11.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:15:0) after 1m0s
[11:11:45.889] Received PubSub notification, asking Buildbucket for the build status
[11:11:46.017] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:11.952] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:15:0)
[11:12:11.952] Timer tick, asking Buildbucket for the build status
[11:12:12.185] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:12.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:17:0) after 1m0s
[11:13:12.260] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:17:0)
[11:13:12.260] Timer tick, asking Buildbucket for the build status
[11:13:12.427] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:12.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:18:0) after 1m0s
[11:14:12.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:18:0)
[11:14:12.607] Timer tick, asking Buildbucket for the build status
[11:14:12.890] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:12.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:19:0) after 1m0s
[11:15:13.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:19:0)
[11:15:13.144] Timer tick, asking Buildbucket for the build status
[11:15:13.383] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:13.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:20:0) after 1m0s
[11:16:13.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:20:0)
[11:16:13.421] Timer tick, asking Buildbucket for the build status
[11:16:13.610] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:13.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:21:0) after 1m0s
[11:17:13.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:21:0)
[11:17:13.639] Timer tick, asking Buildbucket for the build status
[11:17:14.954] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:14.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:22:0) after 1m0s
[11:18:15.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:22:0)
[11:18:15.153] Timer tick, asking Buildbucket for the build status
[11:18:15.360] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:15.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:23:0) after 1m0s
[11:19:15.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:23:0)
[11:19:15.586] Timer tick, asking Buildbucket for the build status
[11:19:16.140] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:16.140] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:24:0) after 1m0s
[11:20:16.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:24:0)
[11:20:16.307] Timer tick, asking Buildbucket for the build status
[11:20:16.440] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:16.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:25:0) after 1m0s
[11:21:16.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:25:0)
[11:21:16.525] Timer tick, asking Buildbucket for the build status
[11:21:16.813] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:16.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:26:0) after 1m0s
[11:22:16.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:26:0)
[11:22:16.940] Timer tick, asking Buildbucket for the build status
[11:22:17.341] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:17.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:27:0) after 1m0s
[11:23:17.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:27:0)
[11:23:17.437] Timer tick, asking Buildbucket for the build status
[11:23:17.660] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:17.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:28:0) after 1m0s
[11:24:17.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:28:0)
[11:24:17.836] Timer tick, asking Buildbucket for the build status
[11:24:18.007] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:18.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:29:0) after 1m0s
[11:25:18.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:29:0)
[11:25:18.132] Timer tick, asking Buildbucket for the build status
[11:25:18.314] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:18.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:30:0) after 1m0s
[11:26:18.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:30:0)
[11:26:18.413] Timer tick, asking Buildbucket for the build status
[11:26:18.785] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:18.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:31:0) after 1m0s
[11:27:18.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:31:0)
[11:27:18.816] Timer tick, asking Buildbucket for the build status
[11:27:18.952] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:18.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:32:0) after 1m0s
[11:28:19.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:32:0)
[11:28:19.009] Timer tick, asking Buildbucket for the build status
[11:28:19.188] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:19.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:33:0) after 1m0s
[11:29:19.229] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:33:0)
[11:29:19.229] Timer tick, asking Buildbucket for the build status
[11:29:19.403] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:19.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:34:0) after 1m0s
[11:30:19.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:34:0)
[11:30:19.426] Timer tick, asking Buildbucket for the build status
[11:30:19.595] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:19.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:35:0) after 1m0s
[11:31:19.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:35:0)
[11:31:19.656] Timer tick, asking Buildbucket for the build status
[11:31:19.859] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:19.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:36:0) after 1m0s
[11:32:19.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:36:0)
[11:32:19.946] Timer tick, asking Buildbucket for the build status
[11:32:20.099] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:20.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:37:0) after 1m0s
[11:33:20.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:37:0)
[11:33:20.236] Timer tick, asking Buildbucket for the build status
[11:33:20.426] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:20.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:38:0) after 1m0s
[11:34:20.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:38:0)
[11:34:20.602] Timer tick, asking Buildbucket for the build status
[11:34:20.980] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:20.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:39:0) after 1m0s
[11:35:21.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:39:0)
[11:35:21.133] Timer tick, asking Buildbucket for the build status
[11:35:21.625] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:21.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:40:0) after 1m0s
[11:36:21.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:40:0)
[11:36:21.665] Timer tick, asking Buildbucket for the build status
[11:36:22.255] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:22.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:41:0) after 1m0s
[11:37:22.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:41:0)
[11:37:22.342] Timer tick, asking Buildbucket for the build status
[11:37:22.496] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:22.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:42:0) after 1m0s
[11:38:22.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:42:0)
[11:38:22.581] Timer tick, asking Buildbucket for the build status
[11:38:22.779] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:22.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:43:0) after 1m0s
[11:39:22.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:43:0)
[11:39:22.901] Timer tick, asking Buildbucket for the build status
[11:39:23.023] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:23.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:44:0) after 1m0s
[11:40:23.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:44:0)
[11:40:23.053] Timer tick, asking Buildbucket for the build status
[11:40:23.338] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:23.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:45:0) after 1m0s
[11:41:23.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:45:0)
[11:41:23.408] Timer tick, asking Buildbucket for the build status
[11:41:23.601] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:23.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:46:0) after 1m0s
[11:42:23.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:46:0)
[11:42:23.625] Timer tick, asking Buildbucket for the build status
[11:42:23.824] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:23.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:47:0) after 1m0s
[11:43:23.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:47:0)
[11:43:23.850] Timer tick, asking Buildbucket for the build status
[11:43:24.137] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:24.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:48:0) after 1m0s
[11:44:24.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:48:0)
[11:44:24.160] Timer tick, asking Buildbucket for the build status
[11:44:24.311] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:24.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:49:0) after 1m0s
[11:45:24.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:49:0)
[11:45:24.413] Timer tick, asking Buildbucket for the build status
[11:45:24.529] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:24.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:50:0) after 1m0s
[11:46:24.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:50:0)
[11:46:24.738] Timer tick, asking Buildbucket for the build status
[11:46:24.856] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:24.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:51:0) after 1m0s
[11:47:25.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:51:0)
[11:47:25.026] Timer tick, asking Buildbucket for the build status
[11:47:26.869] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:26.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:52:0) after 1m0s
[11:48:26.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:52:0)
[11:48:26.923] Timer tick, asking Buildbucket for the build status
[11:48:27.381] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:27.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:53:0) after 1m0s
[11:49:27.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:53:0)
[11:49:27.411] Timer tick, asking Buildbucket for the build status
[11:49:27.772] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:27.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:54:0) after 1m0s
[11:50:27.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:54:0)
[11:50:27.807] Timer tick, asking Buildbucket for the build status
[11:50:27.890] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:27.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:55:0) after 1m0s
[11:51:27.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:55:0)
[11:51:27.896] Timer tick, asking Buildbucket for the build status
[11:51:28.028] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:28.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:56:0) after 1m0s
[11:52:28.090] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:56:0)
[11:52:28.090] Timer tick, asking Buildbucket for the build status
[11:52:28.354] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:28.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:57:0) after 1m0s
[11:53:28.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:57:0)
[11:53:28.420] Timer tick, asking Buildbucket for the build status
[11:53:28.580] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:28.580] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:58:0) after 1m0s
[11:54:28.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:58:0)
[11:54:28.628] Timer tick, asking Buildbucket for the build status
[11:54:28.858] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:28.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:59:0) after 1m0s
[11:55:28.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:59:0)
[11:55:28.900] Timer tick, asking Buildbucket for the build status
[11:55:29.002] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:29.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:60:0) after 1m0s
[11:56:29.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:60:0)
[11:56:29.287] Timer tick, asking Buildbucket for the build status
[11:56:30.339] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:30.340] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:61:0) after 1m0s
[11:57:30.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:61:0)
[11:57:30.576] Timer tick, asking Buildbucket for the build status
[11:57:31.033] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:31.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:62:0) after 1m0s
[11:58:31.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:62:0)
[11:58:31.169] Timer tick, asking Buildbucket for the build status
[11:58:31.434] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:31.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:63:0) after 1m0s
[11:59:31.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:63:0)
[11:59:31.523] Timer tick, asking Buildbucket for the build status
[11:59:32.517] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:32.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:64:0) after 1m0s
[12:00:32.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:64:0)
[12:00:32.698] Timer tick, asking Buildbucket for the build status
[12:00:32.916] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:32.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:65:0) after 1m0s
[12:01:32.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:65:0)
[12:01:32.972] Timer tick, asking Buildbucket for the build status
[12:01:33.126] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:33.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:66:0) after 1m0s
[12:02:33.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:66:0)
[12:02:33.212] Timer tick, asking Buildbucket for the build status
[12:02:33.396] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:33.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:67:0) after 1m0s
[12:03:33.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:67:0)
[12:03:33.489] Timer tick, asking Buildbucket for the build status
[12:03:33.706] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:33.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:68:0) after 1m0s
[12:04:33.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:68:0)
[12:04:33.770] Timer tick, asking Buildbucket for the build status
[12:04:34.383] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:34.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:69:0) after 1m0s
[12:05:34.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:69:0)
[12:05:34.611] Timer tick, asking Buildbucket for the build status
[12:05:34.712] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:34.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:70:0) after 1m0s
[12:06:34.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:70:0)
[12:06:34.921] Timer tick, asking Buildbucket for the build status
[12:06:35.238] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:35.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:71:0) after 1m0s
[12:07:35.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:71:0)
[12:07:35.340] Timer tick, asking Buildbucket for the build status
[12:07:35.700] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:35.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:72:0) after 1m0s
[12:08:35.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:72:0)
[12:08:35.831] Timer tick, asking Buildbucket for the build status
[12:08:35.985] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:35.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:73:0) after 1m0s
[12:09:36.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:73:0)
[12:09:36.114] Timer tick, asking Buildbucket for the build status
[12:09:37.295] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:37.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:74:0) after 1m0s
[12:10:37.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:74:0)
[12:10:37.328] Timer tick, asking Buildbucket for the build status
[12:10:37.675] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:37.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:75:0) after 1m0s
[12:11:37.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:75:0)
[12:11:37.802] Timer tick, asking Buildbucket for the build status
[12:11:38.537] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:38.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:76:0) after 1m0s
[12:12:38.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:76:0)
[12:12:38.635] Timer tick, asking Buildbucket for the build status
[12:12:38.788] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:38.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:77:0) after 1m0s
[12:13:38.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:77:0)
[12:13:38.981] Timer tick, asking Buildbucket for the build status
[12:13:39.256] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:39.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:78:0) after 1m0s
[12:14:39.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:78:0)
[12:14:39.299] Timer tick, asking Buildbucket for the build status
[12:14:39.760] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:39.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:79:0) after 1m0s
[12:15:39.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:79:0)
[12:15:39.786] Timer tick, asking Buildbucket for the build status
[12:15:39.911] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:39.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:80:0) after 1m0s
[12:16:39.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:80:0)
[12:16:39.945] Timer tick, asking Buildbucket for the build status
[12:16:40.068] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:40.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:81:0) after 1m0s
[12:17:40.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:81:0)
[12:17:40.134] Timer tick, asking Buildbucket for the build status
[12:17:40.264] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:40.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:82:0) after 1m0s
[12:18:40.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:82:0)
[12:18:40.331] Timer tick, asking Buildbucket for the build status
[12:18:40.497] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:40.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:83:0) after 1m0s
[12:19:40.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:83:0)
[12:19:40.586] Timer tick, asking Buildbucket for the build status
[12:19:41.319] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:41.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:84:0) after 1m0s
[12:20:41.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:84:0)
[12:20:41.343] Timer tick, asking Buildbucket for the build status
[12:20:41.503] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:41.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:85:0) after 1m0s
[12:21:41.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:85:0)
[12:21:41.541] Timer tick, asking Buildbucket for the build status
[12:21:41.708] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:41.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:86:0) after 1m0s
[12:22:41.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:86:0)
[12:22:41.815] Timer tick, asking Buildbucket for the build status
[12:22:42.027] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:42.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:87:0) after 1m0s
[12:23:42.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:87:0)
[12:23:42.059] Timer tick, asking Buildbucket for the build status
[12:23:42.230] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:42.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:88:0) after 1m0s
[12:24:42.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:88:0)
[12:24:42.299] Timer tick, asking Buildbucket for the build status
[12:24:42.672] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:42.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:89:0) after 1m0s
[12:25:42.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:89:0)
[12:25:42.752] Timer tick, asking Buildbucket for the build status
[12:25:42.965] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:42.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:90:0) after 1m0s
[12:26:42.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:90:0)
[12:26:42.968] Timer tick, asking Buildbucket for the build status
[12:26:43.114] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:43.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:91:0) after 1m0s
[12:27:43.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:91:0)
[12:27:43.172] Timer tick, asking Buildbucket for the build status
[12:27:43.293] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:43.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:92:0) after 1m0s
[12:28:43.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:92:0)
[12:28:43.318] Timer tick, asking Buildbucket for the build status
[12:28:43.397] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:43.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:93:0) after 1m0s
[12:29:43.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:93:0)
[12:29:43.455] Timer tick, asking Buildbucket for the build status
[12:29:43.680] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:43.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:94:0) after 1m0s
[12:30:43.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:94:0)
[12:30:43.787] Timer tick, asking Buildbucket for the build status
[12:30:43.984] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:43.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:95:0) after 1m0s
[12:31:44.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:95:0)
[12:31:44.203] Timer tick, asking Buildbucket for the build status
[12:31:44.387] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:44.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:96:0) after 1m0s
[12:32:44.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:96:0)
[12:32:44.555] Timer tick, asking Buildbucket for the build status
[12:32:44.716] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:44.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:97:0) after 1m0s
[12:33:44.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:97:0)
[12:33:44.784] Timer tick, asking Buildbucket for the build status
[12:33:44.911] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:44.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:98:0) after 1m0s
[12:34:44.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:98:0)
[12:34:44.964] Timer tick, asking Buildbucket for the build status
[12:34:45.437] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:45.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:99:0) after 1m0s
[12:35:45.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:99:0)
[12:35:45.488] Timer tick, asking Buildbucket for the build status
[12:35:45.673] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:45.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:100:0) after 1m0s
[12:36:45.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:100:0)
[12:36:45.995] Timer tick, asking Buildbucket for the build status
[12:36:46.219] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:46.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:101:0) after 1m0s
[12:37:46.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:101:0)
[12:37:46.294] Timer tick, asking Buildbucket for the build status
[12:37:46.660] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:46.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:102:0) after 1m0s
[12:38:46.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:102:0)
[12:38:46.695] Timer tick, asking Buildbucket for the build status
[12:38:46.841] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:46.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:103:0) after 1m0s
[12:39:46.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:103:0)
[12:39:46.937] Timer tick, asking Buildbucket for the build status
[12:39:47.217] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:47.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:104:0) after 1m0s
[12:40:47.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:104:0)
[12:40:47.238] Timer tick, asking Buildbucket for the build status
[12:40:47.566] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:47.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:105:0) after 1m0s
[12:41:47.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:105:0)
[12:41:47.592] Timer tick, asking Buildbucket for the build status
[12:41:47.717] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:47.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:106:0) after 1m0s
[12:42:47.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:106:0)
[12:42:47.755] Timer tick, asking Buildbucket for the build status
[12:42:48.011] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:48.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:107:0) after 1m0s
[12:43:48.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:107:0)
[12:43:48.060] Timer tick, asking Buildbucket for the build status
[12:43:48.265] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:48.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:108:0) after 1m0s
[12:44:48.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:108:0)
[12:44:48.350] Timer tick, asking Buildbucket for the build status
[12:44:49.224] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:49.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:109:0) after 1m0s
[12:45:49.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:109:0)
[12:45:49.344] Timer tick, asking Buildbucket for the build status
[12:45:49.554] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:49.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:110:0) after 1m0s
[12:46:49.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:110:0)
[12:46:49.610] Timer tick, asking Buildbucket for the build status
[12:46:49.775] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:49.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:111:0) after 1m0s
[12:47:49.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:111:0)
[12:47:49.802] Timer tick, asking Buildbucket for the build status
[12:47:50.233] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:50.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:112:0) after 1m0s
[12:48:50.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:112:0)
[12:48:50.264] Timer tick, asking Buildbucket for the build status
[12:48:50.746] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:50.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:113:0) after 1m0s
[12:49:50.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:113:0)
[12:49:50.800] Timer tick, asking Buildbucket for the build status
[12:49:51.322] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:51.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:114:0) after 1m0s
[12:50:51.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:114:0)
[12:50:51.355] Timer tick, asking Buildbucket for the build status
[12:50:51.668] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:51.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:115:0) after 1m0s
[12:51:51.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:115:0)
[12:51:51.722] Timer tick, asking Buildbucket for the build status
[12:51:52.385] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:52.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:116:0) after 1m0s
[12:52:52.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:116:0)
[12:52:52.479] Timer tick, asking Buildbucket for the build status
[12:52:52.743] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:52.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:117:0) after 1m0s
[12:53:52.781] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:117:0)
[12:53:52.781] Timer tick, asking Buildbucket for the build status
[12:53:52.916] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:52.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:118:0) after 1m0s
[12:54:52.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:118:0)
[12:54:52.963] Timer tick, asking Buildbucket for the build status
[12:54:53.394] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:53.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:119:0) after 1m0s
[12:55:53.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:119:0)
[12:55:53.428] Timer tick, asking Buildbucket for the build status
[12:55:53.564] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:53.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:120:0) after 1m0s
[12:56:53.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:120:0)
[12:56:53.613] Timer tick, asking Buildbucket for the build status
[12:56:53.801] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:53.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:121:0) after 1m0s
[12:57:53.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:121:0)
[12:57:53.922] Timer tick, asking Buildbucket for the build status
[12:57:54.360] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:54.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:122:0) after 1m0s
[12:58:54.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:122:0)
[12:58:54.428] Timer tick, asking Buildbucket for the build status
[12:58:54.955] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:54.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:123:0) after 1m0s
[12:59:55.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:123:0)
[12:59:55.029] Timer tick, asking Buildbucket for the build status
[12:59:57.549] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:57.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:124:0) after 1m0s
[13:00:57.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:124:0)
[13:00:57.583] Timer tick, asking Buildbucket for the build status
[13:00:57.802] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:57.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:125:0) after 1m0s
[13:01:57.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:125:0)
[13:01:57.829] Timer tick, asking Buildbucket for the build status
[13:01:57.974] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:57.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:126:0) after 1m0s
[13:02:58.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:126:0)
[13:02:58.029] Timer tick, asking Buildbucket for the build status
[13:02:58.146] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:58.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:127:0) after 1m0s
[13:03:58.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:127:0)
[13:03:58.197] Timer tick, asking Buildbucket for the build status
[13:03:58.311] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:58.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:128:0) after 1m0s
[13:04:58.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:128:0)
[13:04:58.526] Timer tick, asking Buildbucket for the build status
[13:04:58.702] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:58.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:129:0) after 1m0s
[13:05:58.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:129:0)
[13:05:58.751] Timer tick, asking Buildbucket for the build status
[13:05:58.930] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:58.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:130:0) after 1m0s
[13:06:58.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:130:0)
[13:06:58.984] Timer tick, asking Buildbucket for the build status
[13:06:59.162] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:59.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:131:0) after 1m0s
[13:07:59.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:131:0)
[13:07:59.217] Timer tick, asking Buildbucket for the build status
[13:08:02.467] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:02.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:132:0) after 1m0s
[13:09:02.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:132:0)
[13:09:02.571] Timer tick, asking Buildbucket for the build status
[13:09:03.434] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:03.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:133:0) after 1m0s
[13:10:03.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:133:0)
[13:10:03.482] Timer tick, asking Buildbucket for the build status
[13:10:03.774] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:03.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:134:0) after 1m0s
[13:11:03.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:134:0)
[13:11:03.814] Timer tick, asking Buildbucket for the build status
[13:11:04.471] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:04.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:135:0) after 1m0s
[13:12:04.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:135:0)
[13:12:04.471] Timer tick, asking Buildbucket for the build status
[13:12:04.734] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:04.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:136:0) after 1m0s
[13:13:04.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:136:0)
[13:13:04.860] Timer tick, asking Buildbucket for the build status
[13:13:05.268] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:05.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:137:0) after 1m0s
[13:14:05.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:137:0)
[13:14:05.301] Timer tick, asking Buildbucket for the build status
[13:14:05.486] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:05.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:138:0) after 1m0s
[13:15:05.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:138:0)
[13:15:05.516] Timer tick, asking Buildbucket for the build status
[13:15:06.237] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:06.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:139:0) after 1m0s
[13:16:06.305] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:139:0)
[13:16:06.305] Timer tick, asking Buildbucket for the build status
[13:16:06.537] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:06.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:140:0) after 1m0s
[13:17:06.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:140:0)
[13:17:06.631] Timer tick, asking Buildbucket for the build status
[13:17:07.421] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:07.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:141:0) after 1m0s
[13:18:07.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:141:0)
[13:18:07.554] Timer tick, asking Buildbucket for the build status
[13:18:08.039] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:08.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:142:0) after 1m0s
[13:19:08.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:142:0)
[13:19:08.175] Timer tick, asking Buildbucket for the build status
[13:19:08.319] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:08.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:143:0) after 1m0s
[13:20:08.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:143:0)
[13:20:08.370] Timer tick, asking Buildbucket for the build status
[13:20:08.695] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:08.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:144:0) after 1m0s
[13:21:08.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:144:0)
[13:21:08.972] Timer tick, asking Buildbucket for the build status
[13:21:09.137] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:09.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:145:0) after 1m0s
[13:22:09.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:145:0)
[13:22:09.378] Timer tick, asking Buildbucket for the build status
[13:22:09.628] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:09.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:146:0) after 1m0s
[13:23:09.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:146:0)
[13:23:09.662] Timer tick, asking Buildbucket for the build status
[13:23:09.852] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:09.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:147:0) after 1m0s
[13:24:09.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:147:0)
[13:24:09.942] Timer tick, asking Buildbucket for the build status
[13:24:10.124] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:10.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:148:0) after 1m0s
[13:25:10.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:148:0)
[13:25:10.241] Timer tick, asking Buildbucket for the build status
[13:25:10.373] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:10.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:149:0) after 1m0s
[13:26:10.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:149:0)
[13:26:10.437] Timer tick, asking Buildbucket for the build status
[13:26:10.601] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:10.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:150:0) after 1m0s
[13:27:10.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:150:0)
[13:27:10.759] Timer tick, asking Buildbucket for the build status
[13:27:11.338] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:11.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:151:0) after 1m0s
[13:28:11.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:151:0)
[13:28:11.393] Timer tick, asking Buildbucket for the build status
[13:28:11.574] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:11.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:152:0) after 1m0s
[13:29:11.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:152:0)
[13:29:11.682] Timer tick, asking Buildbucket for the build status
[13:29:12.077] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:12.077] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:153:0) after 1m0s
[13:30:12.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:153:0)
[13:30:12.152] Timer tick, asking Buildbucket for the build status
[13:30:13.052] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:13.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:154:0) after 1m0s
[13:31:13.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:154:0)
[13:31:13.146] Timer tick, asking Buildbucket for the build status
[13:31:13.352] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:13.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:155:0) after 1m0s
[13:32:13.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:155:0)
[13:32:13.385] Timer tick, asking Buildbucket for the build status
[13:32:13.625] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:13.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:156:0) after 1m0s
[13:33:13.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:156:0)
[13:33:13.726] Timer tick, asking Buildbucket for the build status
[13:33:13.906] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:13.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:157:0) after 1m0s
[13:34:13.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:157:0)
[13:34:13.963] Timer tick, asking Buildbucket for the build status
[13:34:14.596] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:14.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:158:0) after 1m0s
[13:35:14.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:158:0)
[13:35:14.577] Timer tick, asking Buildbucket for the build status
[13:35:14.709] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:14.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:159:0) after 1m0s
[13:36:14.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:159:0)
[13:36:14.733] Timer tick, asking Buildbucket for the build status
[13:36:14.884] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:14.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:160:0) after 1m0s
[13:37:15.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:160:0)
[13:37:15.112] Timer tick, asking Buildbucket for the build status
[13:37:16.027] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:16.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:161:0) after 1m0s
[13:38:16.170] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:161:0)
[13:38:16.170] Timer tick, asking Buildbucket for the build status
[13:38:16.356] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:16.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:162:0) after 1m0s
[13:39:16.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:162:0)
[13:39:16.644] Timer tick, asking Buildbucket for the build status
[13:39:16.931] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:16.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:163:0) after 1m0s
[13:40:17.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:163:0)
[13:40:17.018] Timer tick, asking Buildbucket for the build status
[13:40:17.556] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:17.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:164:0) after 1m0s
[13:41:17.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:164:0)
[13:41:17.616] Timer tick, asking Buildbucket for the build status
[13:41:17.804] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:17.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:165:0) after 1m0s
[13:42:17.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:165:0)
[13:42:17.804] Timer tick, asking Buildbucket for the build status
[13:42:18.014] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:18.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:166:0) after 1m0s
[13:43:18.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:166:0)
[13:43:18.071] Timer tick, asking Buildbucket for the build status
[13:43:18.309] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:18.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:167:0) after 1m0s
[13:44:18.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:167:0)
[13:44:18.357] Timer tick, asking Buildbucket for the build status
[13:44:18.540] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:18.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:168:0) after 1m0s
[13:45:18.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:168:0)
[13:45:18.548] Timer tick, asking Buildbucket for the build status
[13:45:18.761] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:18.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:169:0) after 1m0s
[13:46:18.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:169:0)
[13:46:18.825] Timer tick, asking Buildbucket for the build status
[13:46:19.063] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:19.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:170:0) after 1m0s
[13:47:19.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:170:0)
[13:47:19.103] Timer tick, asking Buildbucket for the build status
[13:47:19.453] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:19.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:171:0) after 1m0s
[13:48:19.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:171:0)
[13:48:19.442] Timer tick, asking Buildbucket for the build status
[13:48:20.170] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:20.170] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:172:0) after 1m0s
[13:49:20.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:172:0)
[13:49:20.210] Timer tick, asking Buildbucket for the build status
[13:49:20.348] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:20.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:173:0) after 1m0s
[13:50:20.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:173:0)
[13:50:20.371] Timer tick, asking Buildbucket for the build status
[13:50:20.568] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:20.568] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:174:0) after 1m0s
[13:51:20.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:174:0)
[13:51:20.701] Timer tick, asking Buildbucket for the build status
[13:51:20.913] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:20.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:175:0) after 1m0s
[13:52:21.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:175:0)
[13:52:21.076] Timer tick, asking Buildbucket for the build status
[13:52:21.345] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:21.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:176:0) after 1m0s
[13:53:21.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:176:0)
[13:53:21.584] Timer tick, asking Buildbucket for the build status
[13:53:21.742] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:21.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:177:0) after 1m0s
[13:54:22.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:177:0)
[13:54:22.065] Timer tick, asking Buildbucket for the build status
[13:54:24.162] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:24.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:178:0) after 1m0s
[13:55:24.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:178:0)
[13:55:24.382] Timer tick, asking Buildbucket for the build status
[13:55:24.534] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:24.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:179:0) after 1m0s
[13:56:25.180] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:179:0)
[13:56:25.180] Timer tick, asking Buildbucket for the build status
[13:56:25.355] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:25.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:180:0) after 1m0s
[13:57:27.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:180:0)
[13:57:27.083] Timer tick, asking Buildbucket for the build status
[13:57:27.257] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:27.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:181:0) after 1m0s
[13:58:27.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:181:0)
[13:58:27.448] Timer tick, asking Buildbucket for the build status
[13:58:28.380] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:28.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:182:0) after 1m0s
[13:59:28.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:182:0)
[13:59:28.510] Timer tick, asking Buildbucket for the build status
[13:59:29.647] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:29.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:183:0) after 1m0s
[14:00:29.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:183:0)
[14:00:29.821] Timer tick, asking Buildbucket for the build status
[14:00:29.970] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:29.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:184:0) after 1m0s
[14:01:30.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:184:0)
[14:01:30.085] Timer tick, asking Buildbucket for the build status
[14:01:30.291] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:30.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:185:0) after 1m0s
[14:02:30.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:185:0)
[14:02:30.550] Timer tick, asking Buildbucket for the build status
[14:02:30.747] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:30.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:186:0) after 1m0s
[14:03:31.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:186:0)
[14:03:31.132] Timer tick, asking Buildbucket for the build status
[14:03:31.599] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:31.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:187:0) after 1m0s
[14:04:31.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:187:0)
[14:04:31.676] Timer tick, asking Buildbucket for the build status
[14:04:32.802] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:32.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:188:0) after 1m0s
[14:05:32.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:188:0)
[14:05:32.824] Timer tick, asking Buildbucket for the build status
[14:05:33.072] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:33.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:189:0) after 1m0s
[14:06:33.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:189:0)
[14:06:33.169] Timer tick, asking Buildbucket for the build status
[14:06:33.281] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:33.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:190:0) after 1m0s
[14:07:33.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:190:0)
[14:07:33.362] Timer tick, asking Buildbucket for the build status
[14:07:33.502] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:33.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:191:0) after 1m0s
[14:08:33.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:191:0)
[14:08:33.590] Timer tick, asking Buildbucket for the build status
[14:08:33.771] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:33.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:192:0) after 1m0s
[14:09:33.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:192:0)
[14:09:33.870] Timer tick, asking Buildbucket for the build status
[14:09:35.214] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:35.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:193:0) after 1m0s
[14:10:35.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:193:0)
[14:10:35.275] Timer tick, asking Buildbucket for the build status
[14:10:35.501] Build 8882776635935871376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:35.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048206699831826176:194:0) after 1m0s
[14:10:37.657] Received PubSub notification, asking Buildbucket for the build status
[14:10:37.748] Build 8882776635935871376: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:10:37.748] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "completed_ts": "1587132634929801",
    "created_by": "project:infra",
    "created_ts": "1587121086142648",
    "id": "8882776635935871376",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4114.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"670623c1-f237-40bf-9276-536624281f05\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4114.3\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4114.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"670623c1-f237-40bf-9276-536624281f05\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-twpf\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"84.0.4114.3\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-twpf\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4985-2a273fe\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1587121905180971",
    "status": "COMPLETED",
    "status_changed_ts": "1587132636961611",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9048206699831826176",
      "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/8882776635935871376/+/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:4ba09b6c2ffb4b10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1587132637067232",
    "url": "https://ci.chromium.org/b/8882776635935871376",
    "utcnow_ts": "1587132637730416"
  }
}
[14:10:37.748] Invocation finished in 3h12m34.705476026s with status SUCCEEDED