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

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

{
  "version": "88.0.4323.4"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[11:42:16.411] New invocation is queued and will start shortly
[11:42:16.411] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[11:42:17.495] Starting the invocation (attempt 1)
[11:42:17.561] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:42:17.561] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:42:17.561] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9029178554648452768",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4323.4\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"51a2028b-2890-4fde-932a-20befcd04f79\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4323.4\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9029178554648452768",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[11:42:18.058] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1605267737682814",
    "id": "8863748492650900992",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4323.4\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"51a2028b-2890-4fde-932a-20befcd04f79\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4323.4\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1605267737892278",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9029178554648452768",
      "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/8863748492650900992/+/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": "1605267737892461",
    "url": "https://ci.chromium.org/b/8863748492650900992",
    "utcnow_ts": "1605267738049706"
  }
}
[11:42:18.058] Task URL: https://ci.chromium.org/b/8863748492650900992
[11:42:18.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:2:0) after 1m0s
[11:43:18.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:2:0)
[11:43:18.153] Timer tick, asking Buildbucket for the build status
[11:43:18.314] Build 8863748492650900992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:43:18.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:3:0) after 1m0s
[11:44:18.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:3:0)
[11:44:18.426] Timer tick, asking Buildbucket for the build status
[11:44:18.558] Build 8863748492650900992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:44:18.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:4:0) after 1m0s
[11:45:18.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:4:0)
[11:45:18.582] Timer tick, asking Buildbucket for the build status
[11:45:18.702] Build 8863748492650900992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:45:18.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:5:0) after 1m0s
[11:46:18.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:5:0)
[11:46:18.736] Timer tick, asking Buildbucket for the build status
[11:46:18.814] Build 8863748492650900992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:46:18.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:6:0) after 1m0s
[11:47:18.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:6:0)
[11:47:18.854] Timer tick, asking Buildbucket for the build status
[11:47:19.093] Build 8863748492650900992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:47:19.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:7:0) after 1m0s
[11:47:19.505] Received PubSub notification, asking Buildbucket for the build status
[11:47:19.841] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:19.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:7:0)
[11:48:19.116] Timer tick, asking Buildbucket for the build status
[11:48:19.246] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:19.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:9:0) after 1m0s
[11:49:19.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:9:0)
[11:49:19.306] Timer tick, asking Buildbucket for the build status
[11:49:19.391] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:19.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:10:0) after 1m0s
[11:50:19.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:10:0)
[11:50:19.493] Timer tick, asking Buildbucket for the build status
[11:50:19.608] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:19.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:11:0) after 1m0s
[11:51:19.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:11:0)
[11:51:19.625] Timer tick, asking Buildbucket for the build status
[11:51:19.725] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:19.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:12:0) after 1m0s
[11:52:19.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:12:0)
[11:52:19.753] Timer tick, asking Buildbucket for the build status
[11:52:19.861] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:19.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:13:0) after 1m0s
[11:53:19.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:13:0)
[11:53:19.896] Timer tick, asking Buildbucket for the build status
[11:53:19.982] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:19.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:14:0) after 1m0s
[11:54:20.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:14:0)
[11:54:20.052] Timer tick, asking Buildbucket for the build status
[11:54:20.141] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:20.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:15:0) after 1m0s
[11:55:20.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:15:0)
[11:55:20.142] Timer tick, asking Buildbucket for the build status
[11:55:20.223] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:20.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:16:0) after 1m0s
[11:56:20.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:16:0)
[11:56:20.272] Timer tick, asking Buildbucket for the build status
[11:56:20.367] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:20.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:17:0) after 1m0s
[11:57:20.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:17:0)
[11:57:20.392] Timer tick, asking Buildbucket for the build status
[11:57:20.499] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:20.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:18:0) after 1m0s
[11:58:20.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:18:0)
[11:58:20.546] Timer tick, asking Buildbucket for the build status
[11:58:20.626] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:20.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:19:0) after 1m0s
[11:59:20.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:19:0)
[11:59:20.668] Timer tick, asking Buildbucket for the build status
[11:59:20.766] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:20.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:20:0) after 1m0s
[12:00:20.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:20:0)
[12:00:20.870] Timer tick, asking Buildbucket for the build status
[12:00:22.530] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:22.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:21:0) after 1m0s
[12:01:22.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:21:0)
[12:01:22.608] Timer tick, asking Buildbucket for the build status
[12:01:22.801] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:22.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:22:0) after 1m0s
[12:02:22.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:22:0)
[12:02:22.911] Timer tick, asking Buildbucket for the build status
[12:02:23.080] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:23.080] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:23:0) after 1m0s
[12:03:23.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:23:0)
[12:03:23.276] Timer tick, asking Buildbucket for the build status
[12:03:23.362] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:23.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:24:0) after 1m0s
[12:04:23.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:24:0)
[12:04:23.489] Timer tick, asking Buildbucket for the build status
[12:04:23.571] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:23.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:25:0) after 1m0s
[12:05:23.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:25:0)
[12:05:23.609] Timer tick, asking Buildbucket for the build status
[12:05:23.690] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:23.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:26:0) after 1m0s
[12:06:23.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:26:0)
[12:06:23.769] Timer tick, asking Buildbucket for the build status
[12:06:24.413] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:24.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:27:0) after 1m0s
[12:07:24.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:27:0)
[12:07:24.506] Timer tick, asking Buildbucket for the build status
[12:07:24.848] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:24.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:28:0) after 1m0s
[12:08:24.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:28:0)
[12:08:24.886] Timer tick, asking Buildbucket for the build status
[12:08:25.053] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:25.053] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:29:0) after 1m0s
[12:09:25.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:29:0)
[12:09:25.062] Timer tick, asking Buildbucket for the build status
[12:09:25.185] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:25.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:30:0) after 1m0s
[12:10:25.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:30:0)
[12:10:25.290] Timer tick, asking Buildbucket for the build status
[12:10:25.382] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:25.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:31:0) after 1m0s
[12:11:25.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:31:0)
[12:11:25.508] Timer tick, asking Buildbucket for the build status
[12:11:25.597] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:25.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:32:0) after 1m0s
[12:12:25.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:32:0)
[12:12:25.621] Timer tick, asking Buildbucket for the build status
[12:12:25.746] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:25.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:33:0) after 1m0s
[12:13:25.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:33:0)
[12:13:25.808] Timer tick, asking Buildbucket for the build status
[12:13:25.980] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:25.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:34:0) after 1m0s
[12:14:25.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:34:0)
[12:14:25.968] Timer tick, asking Buildbucket for the build status
[12:14:26.047] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:26.047] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:35:0) after 1m0s
[12:15:26.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:35:0)
[12:15:26.065] Timer tick, asking Buildbucket for the build status
[12:15:26.283] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:26.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:36:0) after 1m0s
[12:16:26.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:36:0)
[12:16:26.441] Timer tick, asking Buildbucket for the build status
[12:16:26.514] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:26.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:37:0) after 1m0s
[12:17:26.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:37:0)
[12:17:26.526] Timer tick, asking Buildbucket for the build status
[12:17:26.737] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:26.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:38:0) after 1m0s
[12:18:26.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:38:0)
[12:18:26.827] Timer tick, asking Buildbucket for the build status
[12:18:26.940] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:26.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:39:0) after 1m0s
[12:19:27.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:39:0)
[12:19:27.082] Timer tick, asking Buildbucket for the build status
[12:19:27.172] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:27.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:40:0) after 1m0s
[12:20:27.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:40:0)
[12:20:27.203] Timer tick, asking Buildbucket for the build status
[12:20:27.297] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:27.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:41:0) after 1m0s
[12:21:27.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:41:0)
[12:21:27.396] Timer tick, asking Buildbucket for the build status
[12:21:27.896] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:27.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:42:0) after 1m0s
[12:22:28.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:42:0)
[12:22:28.117] Timer tick, asking Buildbucket for the build status
[12:22:28.237] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:28.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:43:0) after 1m0s
[12:23:28.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:43:0)
[12:23:28.441] Timer tick, asking Buildbucket for the build status
[12:23:28.696] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:28.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:44:0) after 1m0s
[12:24:28.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:44:0)
[12:24:28.901] Timer tick, asking Buildbucket for the build status
[12:24:29.062] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:29.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:45:0) after 1m0s
[12:25:29.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:45:0)
[12:25:29.298] Timer tick, asking Buildbucket for the build status
[12:25:29.442] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:29.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:46:0) after 1m0s
[12:26:29.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:46:0)
[12:26:29.597] Timer tick, asking Buildbucket for the build status
[12:26:29.704] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:29.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:47:0) after 1m0s
[12:27:29.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:47:0)
[12:27:29.969] Timer tick, asking Buildbucket for the build status
[12:27:30.157] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:30.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:48:0) after 1m0s
[12:28:30.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:48:0)
[12:28:30.198] Timer tick, asking Buildbucket for the build status
[12:28:30.300] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:30.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:49:0) after 1m0s
[12:29:30.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:49:0)
[12:29:30.508] Timer tick, asking Buildbucket for the build status
[12:29:30.643] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:30.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:50:0) after 1m0s
[12:30:30.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:50:0)
[12:30:30.825] Timer tick, asking Buildbucket for the build status
[12:30:31.472] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:31.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:51:0) after 1m0s
[12:31:31.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:51:0)
[12:31:31.740] Timer tick, asking Buildbucket for the build status
[12:31:31.989] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:31.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:52:0) after 1m0s
[12:32:32.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:52:0)
[12:32:32.078] Timer tick, asking Buildbucket for the build status
[12:32:33.062] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:33.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:53:0) after 1m0s
[12:33:33.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:53:0)
[12:33:33.181] Timer tick, asking Buildbucket for the build status
[12:33:33.658] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:33.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:54:0) after 1m0s
[12:34:33.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:54:0)
[12:34:33.723] Timer tick, asking Buildbucket for the build status
[12:34:34.127] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:34.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:55:0) after 1m0s
[12:35:34.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:55:0)
[12:35:34.286] Timer tick, asking Buildbucket for the build status
[12:35:35.020] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:35.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:56:0) after 1m0s
[12:36:35.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:56:0)
[12:36:35.197] Timer tick, asking Buildbucket for the build status
[12:36:35.339] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:35.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:57:0) after 1m0s
[12:37:35.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:57:0)
[12:37:35.446] Timer tick, asking Buildbucket for the build status
[12:37:35.579] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:35.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:58:0) after 1m0s
[12:38:35.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:58:0)
[12:38:35.754] Timer tick, asking Buildbucket for the build status
[12:38:35.979] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:35.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:59:0) after 1m0s
[12:39:36.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:59:0)
[12:39:36.082] Timer tick, asking Buildbucket for the build status
[12:39:36.222] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:36.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:60:0) after 1m0s
[12:40:36.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:60:0)
[12:40:36.318] Timer tick, asking Buildbucket for the build status
[12:40:36.442] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:36.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:61:0) after 1m0s
[12:41:36.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:61:0)
[12:41:36.526] Timer tick, asking Buildbucket for the build status
[12:41:36.776] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:36.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:62:0) after 1m0s
[12:42:36.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:62:0)
[12:42:36.808] Timer tick, asking Buildbucket for the build status
[12:42:36.921] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:36.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:63:0) after 1m0s
[12:43:36.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:63:0)
[12:43:36.991] Timer tick, asking Buildbucket for the build status
[12:43:37.485] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:37.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:64:0) after 1m0s
[12:44:37.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:64:0)
[12:44:37.476] Timer tick, asking Buildbucket for the build status
[12:44:37.619] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:37.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:65:0) after 1m0s
[12:45:37.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:65:0)
[12:45:37.660] Timer tick, asking Buildbucket for the build status
[12:45:37.749] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:37.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:66:0) after 1m0s
[12:46:37.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:66:0)
[12:46:37.834] Timer tick, asking Buildbucket for the build status
[12:46:37.951] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:37.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:67:0) after 1m0s
[12:47:38.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:67:0)
[12:47:38.038] Timer tick, asking Buildbucket for the build status
[12:47:38.208] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:38.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:68:0) after 1m0s
[12:48:38.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:68:0)
[12:48:38.289] Timer tick, asking Buildbucket for the build status
[12:48:38.376] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:38.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:69:0) after 1m0s
[12:49:38.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:69:0)
[12:49:38.412] Timer tick, asking Buildbucket for the build status
[12:49:38.495] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:38.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:70:0) after 1m0s
[12:50:38.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:70:0)
[12:50:38.589] Timer tick, asking Buildbucket for the build status
[12:50:38.927] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:38.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:71:0) after 1m0s
[12:51:38.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:71:0)
[12:51:38.995] Timer tick, asking Buildbucket for the build status
[12:51:39.317] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:39.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:72:0) after 1m0s
[12:52:39.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:72:0)
[12:52:39.337] Timer tick, asking Buildbucket for the build status
[12:52:39.702] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:39.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:73:0) after 1m0s
[12:53:39.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:73:0)
[12:53:39.818] Timer tick, asking Buildbucket for the build status
[12:53:39.918] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:39.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:74:0) after 1m0s
[12:54:40.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:74:0)
[12:54:40.021] Timer tick, asking Buildbucket for the build status
[12:54:40.164] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:40.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:75:0) after 1m0s
[12:55:40.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:75:0)
[12:55:40.226] Timer tick, asking Buildbucket for the build status
[12:55:40.574] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:40.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:76:0) after 1m0s
[12:56:40.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:76:0)
[12:56:40.671] Timer tick, asking Buildbucket for the build status
[12:56:41.354] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:41.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:77:0) after 1m0s
[12:57:41.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:77:0)
[12:57:41.435] Timer tick, asking Buildbucket for the build status
[12:57:41.792] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:41.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:78:0) after 1m0s
[12:58:41.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:78:0)
[12:58:41.923] Timer tick, asking Buildbucket for the build status
[12:58:42.043] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:42.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:79:0) after 1m0s
[12:59:42.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:79:0)
[12:59:42.294] Timer tick, asking Buildbucket for the build status
[12:59:42.384] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:42.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:80:0) after 1m0s
[13:00:42.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:80:0)
[13:00:42.418] Timer tick, asking Buildbucket for the build status
[13:00:43.862] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:43.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:81:0) after 1m0s
[13:01:43.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:81:0)
[13:01:43.906] Timer tick, asking Buildbucket for the build status
[13:01:44.068] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:44.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:82:0) after 1m0s
[13:02:44.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:82:0)
[13:02:44.114] Timer tick, asking Buildbucket for the build status
[13:02:44.706] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:44.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:83:0) after 1m0s
[13:03:44.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:83:0)
[13:03:44.756] Timer tick, asking Buildbucket for the build status
[13:03:44.857] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:44.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:84:0) after 1m0s
[13:04:44.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:84:0)
[13:04:44.891] Timer tick, asking Buildbucket for the build status
[13:04:44.977] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:44.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:85:0) after 1m0s
[13:05:45.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:85:0)
[13:05:45.076] Timer tick, asking Buildbucket for the build status
[13:05:45.195] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:45.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:86:0) after 1m0s
[13:06:45.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:86:0)
[13:06:45.225] Timer tick, asking Buildbucket for the build status
[13:06:45.349] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:45.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:87:0) after 1m0s
[13:07:55.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:87:0)
[13:07:55.664] Timer tick, asking Buildbucket for the build status
[13:07:55.914] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:55.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:88:0) after 1m0s
[13:08:55.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:88:0)
[13:08:55.955] Timer tick, asking Buildbucket for the build status
[13:08:56.125] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:56.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:89:0) after 1m0s
[13:09:56.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:89:0)
[13:09:56.138] Timer tick, asking Buildbucket for the build status
[13:09:56.235] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:56.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:90:0) after 1m0s
[13:10:56.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:90:0)
[13:10:56.245] Timer tick, asking Buildbucket for the build status
[13:10:56.362] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:56.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:91:0) after 1m0s
[13:11:56.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:91:0)
[13:11:56.397] Timer tick, asking Buildbucket for the build status
[13:11:57.108] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:57.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:92:0) after 1m0s
[13:12:57.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:92:0)
[13:12:57.172] Timer tick, asking Buildbucket for the build status
[13:12:57.282] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:57.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:93:0) after 1m0s
[13:13:57.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:93:0)
[13:13:57.311] Timer tick, asking Buildbucket for the build status
[13:13:57.421] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:57.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:94:0) after 1m0s
[13:14:57.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:94:0)
[13:14:57.464] Timer tick, asking Buildbucket for the build status
[13:14:57.677] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:57.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:95:0) after 1m0s
[13:15:57.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:95:0)
[13:15:57.734] Timer tick, asking Buildbucket for the build status
[13:15:57.816] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:57.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:96:0) after 1m0s
[13:16:57.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:96:0)
[13:16:57.839] Timer tick, asking Buildbucket for the build status
[13:16:57.913] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:57.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:97:0) after 1m0s
[13:17:57.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:97:0)
[13:17:57.936] Timer tick, asking Buildbucket for the build status
[13:17:58.070] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:58.070] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:98:0) after 1m0s
[13:18:58.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:98:0)
[13:18:58.106] Timer tick, asking Buildbucket for the build status
[13:18:59.891] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:59.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:99:0) after 1m0s
[13:19:59.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:99:0)
[13:19:59.992] Timer tick, asking Buildbucket for the build status
[13:20:00.239] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:00.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:100:0) after 1m0s
[13:21:00.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:100:0)
[13:21:00.273] Timer tick, asking Buildbucket for the build status
[13:21:00.629] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:00.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:101:0) after 1m0s
[13:22:02.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:101:0)
[13:22:02.416] Timer tick, asking Buildbucket for the build status
[13:22:02.712] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:02.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:102:0) after 1m0s
[13:23:02.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:102:0)
[13:23:02.813] Timer tick, asking Buildbucket for the build status
[13:23:03.116] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:03.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:103:0) after 1m0s
[13:24:03.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:103:0)
[13:24:03.150] Timer tick, asking Buildbucket for the build status
[13:24:03.512] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:03.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:104:0) after 1m0s
[13:25:03.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:104:0)
[13:25:03.546] Timer tick, asking Buildbucket for the build status
[13:25:03.628] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:03.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:105:0) after 1m0s
[13:26:03.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:105:0)
[13:26:03.694] Timer tick, asking Buildbucket for the build status
[13:26:04.010] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:04.010] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:106:0) after 1m0s
[13:27:04.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:106:0)
[13:27:04.042] Timer tick, asking Buildbucket for the build status
[13:27:04.132] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:04.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:107:0) after 1m0s
[13:28:04.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:107:0)
[13:28:04.169] Timer tick, asking Buildbucket for the build status
[13:28:04.307] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:04.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:108:0) after 1m0s
[13:29:04.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:108:0)
[13:29:04.400] Timer tick, asking Buildbucket for the build status
[13:29:04.563] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:04.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:109:0) after 1m0s
[13:30:04.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:109:0)
[13:30:04.616] Timer tick, asking Buildbucket for the build status
[13:30:04.887] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:04.887] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:110:0) after 1m0s
[13:31:04.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:110:0)
[13:31:04.938] Timer tick, asking Buildbucket for the build status
[13:31:05.043] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:05.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:111:0) after 1m0s
[13:32:05.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:111:0)
[13:32:05.073] Timer tick, asking Buildbucket for the build status
[13:32:05.300] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:05.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:112:0) after 1m0s
[13:33:05.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:112:0)
[13:33:05.426] Timer tick, asking Buildbucket for the build status
[13:33:06.034] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:06.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:113:0) after 1m0s
[13:34:06.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:113:0)
[13:34:06.166] Timer tick, asking Buildbucket for the build status
[13:34:06.536] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:06.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:114:0) after 1m0s
[13:35:06.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:114:0)
[13:35:06.595] Timer tick, asking Buildbucket for the build status
[13:35:06.914] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:06.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:115:0) after 1m0s
[13:36:06.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:115:0)
[13:36:06.949] Timer tick, asking Buildbucket for the build status
[13:36:07.046] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:07.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:116:0) after 1m0s
[13:37:07.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:116:0)
[13:37:07.092] Timer tick, asking Buildbucket for the build status
[13:37:07.319] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:07.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:117:0) after 1m0s
[13:38:07.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:117:0)
[13:38:07.314] Timer tick, asking Buildbucket for the build status
[13:38:07.445] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:07.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:118:0) after 1m0s
[13:39:07.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:118:0)
[13:39:07.486] Timer tick, asking Buildbucket for the build status
[13:39:07.558] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:07.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:119:0) after 1m0s
[13:40:07.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:119:0)
[13:40:07.615] Timer tick, asking Buildbucket for the build status
[13:40:07.709] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:07.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:120:0) after 1m0s
[13:41:07.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:120:0)
[13:41:07.746] Timer tick, asking Buildbucket for the build status
[13:41:11.653] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:11.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:121:0) after 1m0s
[13:42:11.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:121:0)
[13:42:11.887] Timer tick, asking Buildbucket for the build status
[13:42:12.107] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:12.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:122:0) after 1m0s
[13:43:12.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:122:0)
[13:43:12.158] Timer tick, asking Buildbucket for the build status
[13:43:12.397] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:12.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:123:0) after 1m0s
[13:44:12.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:123:0)
[13:44:12.495] Timer tick, asking Buildbucket for the build status
[13:44:12.650] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:12.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:124:0) after 1m0s
[13:45:12.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:124:0)
[13:45:12.947] Timer tick, asking Buildbucket for the build status
[13:45:13.158] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:13.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:125:0) after 1m0s
[13:46:13.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:125:0)
[13:46:13.203] Timer tick, asking Buildbucket for the build status
[13:46:13.511] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:13.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:126:0) after 1m0s
[13:47:13.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:126:0)
[13:47:13.595] Timer tick, asking Buildbucket for the build status
[13:47:13.669] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:13.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:127:0) after 1m0s
[13:48:13.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:127:0)
[13:48:13.708] Timer tick, asking Buildbucket for the build status
[13:48:13.814] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:13.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:128:0) after 1m0s
[13:49:14.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:128:0)
[13:49:14.023] Timer tick, asking Buildbucket for the build status
[13:49:14.133] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:14.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:129:0) after 1m0s
[13:50:14.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:129:0)
[13:50:14.362] Timer tick, asking Buildbucket for the build status
[13:50:14.639] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:14.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:130:0) after 1m0s
[13:51:14.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:130:0)
[13:51:14.821] Timer tick, asking Buildbucket for the build status
[13:51:14.913] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:14.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:131:0) after 1m0s
[13:52:15.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:131:0)
[13:52:15.122] Timer tick, asking Buildbucket for the build status
[13:52:15.209] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:15.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:132:0) after 1m0s
[13:53:15.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:132:0)
[13:53:15.356] Timer tick, asking Buildbucket for the build status
[13:53:15.496] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:15.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:133:0) after 1m0s
[13:54:15.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:133:0)
[13:54:15.555] Timer tick, asking Buildbucket for the build status
[13:54:15.926] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:15.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:134:0) after 1m0s
[13:55:16.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:134:0)
[13:55:16.184] Timer tick, asking Buildbucket for the build status
[13:55:16.257] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:16.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:135:0) after 1m0s
[13:56:16.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:135:0)
[13:56:16.330] Timer tick, asking Buildbucket for the build status
[13:56:16.423] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:16.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:136:0) after 1m0s
[13:57:16.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:136:0)
[13:57:16.532] Timer tick, asking Buildbucket for the build status
[13:57:16.620] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:16.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:137:0) after 1m0s
[13:58:16.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:137:0)
[13:58:16.842] Timer tick, asking Buildbucket for the build status
[13:58:16.981] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:16.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:138:0) after 1m0s
[13:59:17.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:138:0)
[13:59:17.186] Timer tick, asking Buildbucket for the build status
[13:59:17.410] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:17.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:139:0) after 1m0s
[14:00:17.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:139:0)
[14:00:17.428] Timer tick, asking Buildbucket for the build status
[14:00:19.415] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:19.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:140:0) after 1m0s
[14:01:19.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:140:0)
[14:01:19.682] Timer tick, asking Buildbucket for the build status
[14:01:19.905] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:19.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:141:0) after 1m0s
[14:02:19.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:141:0)
[14:02:19.999] Timer tick, asking Buildbucket for the build status
[14:02:21.546] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:21.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:142:0) after 1m0s
[14:03:21.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:142:0)
[14:03:21.688] Timer tick, asking Buildbucket for the build status
[14:03:21.791] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:21.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:143:0) after 1m0s
[14:04:21.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:143:0)
[14:04:21.852] Timer tick, asking Buildbucket for the build status
[14:04:21.958] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:21.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:144:0) after 1m0s
[14:05:22.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:144:0)
[14:05:22.151] Timer tick, asking Buildbucket for the build status
[14:05:24.251] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:24.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:145:0) after 1m0s
[14:06:24.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:145:0)
[14:06:24.405] Timer tick, asking Buildbucket for the build status
[14:06:24.486] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:24.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:146:0) after 1m0s
[14:07:24.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:146:0)
[14:07:24.548] Timer tick, asking Buildbucket for the build status
[14:07:24.745] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:24.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:147:0) after 1m0s
[14:08:24.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:147:0)
[14:08:24.816] Timer tick, asking Buildbucket for the build status
[14:08:24.930] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:24.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:148:0) after 1m0s
[14:09:25.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:148:0)
[14:09:25.013] Timer tick, asking Buildbucket for the build status
[14:09:25.173] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:25.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:149:0) after 1m0s
[14:10:25.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:149:0)
[14:10:25.301] Timer tick, asking Buildbucket for the build status
[14:10:25.592] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:25.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:150:0) after 1m0s
[14:11:25.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:150:0)
[14:11:25.689] Timer tick, asking Buildbucket for the build status
[14:11:25.759] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:25.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:151:0) after 1m0s
[14:12:25.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:151:0)
[14:12:25.814] Timer tick, asking Buildbucket for the build status
[14:12:25.970] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:25.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:152:0) after 1m0s
[14:13:26.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:152:0)
[14:13:26.073] Timer tick, asking Buildbucket for the build status
[14:13:26.275] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:26.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:153:0) after 1m0s
[14:14:26.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:153:0)
[14:14:26.336] Timer tick, asking Buildbucket for the build status
[14:14:26.439] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:26.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:154:0) after 1m0s
[14:15:26.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:154:0)
[14:15:26.530] Timer tick, asking Buildbucket for the build status
[14:15:26.679] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:26.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:155:0) after 1m0s
[14:16:26.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:155:0)
[14:16:26.718] Timer tick, asking Buildbucket for the build status
[14:16:27.083] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:27.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:156:0) after 1m0s
[14:17:27.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:156:0)
[14:17:27.083] Timer tick, asking Buildbucket for the build status
[14:17:27.181] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:27.181] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:157:0) after 1m0s
[14:18:27.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:157:0)
[14:18:27.322] Timer tick, asking Buildbucket for the build status
[14:18:27.428] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:27.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:158:0) after 1m0s
[14:19:27.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:158:0)
[14:19:27.467] Timer tick, asking Buildbucket for the build status
[14:19:27.728] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:27.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:159:0) after 1m0s
[14:20:27.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:159:0)
[14:20:27.769] Timer tick, asking Buildbucket for the build status
[14:20:27.901] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:27.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:160:0) after 1m0s
[14:21:28.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:160:0)
[14:21:28.022] Timer tick, asking Buildbucket for the build status
[14:21:29.426] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:29.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:161:0) after 1m0s
[14:22:29.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:161:0)
[14:22:29.469] Timer tick, asking Buildbucket for the build status
[14:22:31.005] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:31.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:162:0) after 1m0s
[14:23:31.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:162:0)
[14:23:31.102] Timer tick, asking Buildbucket for the build status
[14:23:31.230] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:31.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:163:0) after 1m0s
[14:24:31.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:163:0)
[14:24:31.293] Timer tick, asking Buildbucket for the build status
[14:24:31.425] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:31.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:164:0) after 1m0s
[14:25:31.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:164:0)
[14:25:31.446] Timer tick, asking Buildbucket for the build status
[14:25:31.549] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:31.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:165:0) after 1m0s
[14:26:31.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:165:0)
[14:26:31.556] Timer tick, asking Buildbucket for the build status
[14:26:31.628] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:31.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:166:0) after 1m0s
[14:27:31.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:166:0)
[14:27:31.656] Timer tick, asking Buildbucket for the build status
[14:27:31.743] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:31.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:167:0) after 1m0s
[14:28:31.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:167:0)
[14:28:31.834] Timer tick, asking Buildbucket for the build status
[14:28:31.960] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:31.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:168:0) after 1m0s
[14:29:32.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:168:0)
[14:29:32.024] Timer tick, asking Buildbucket for the build status
[14:29:32.161] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:32.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:169:0) after 1m0s
[14:30:32.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:169:0)
[14:30:32.182] Timer tick, asking Buildbucket for the build status
[14:30:32.267] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:32.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:170:0) after 1m0s
[14:31:32.310] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:170:0)
[14:31:32.310] Timer tick, asking Buildbucket for the build status
[14:31:32.440] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:32.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:171:0) after 1m0s
[14:32:32.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:171:0)
[14:32:32.478] Timer tick, asking Buildbucket for the build status
[14:32:32.684] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:32.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:172:0) after 1m0s
[14:33:32.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:172:0)
[14:33:32.760] Timer tick, asking Buildbucket for the build status
[14:33:33.134] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:33.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:173:0) after 1m0s
[14:34:33.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:173:0)
[14:34:33.154] Timer tick, asking Buildbucket for the build status
[14:34:34.626] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:34.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:174:0) after 1m0s
[14:35:34.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:174:0)
[14:35:34.657] Timer tick, asking Buildbucket for the build status
[14:35:34.812] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:34.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:175:0) after 1m0s
[14:36:34.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:175:0)
[14:36:34.866] Timer tick, asking Buildbucket for the build status
[14:36:34.998] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:34.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:176:0) after 1m0s
[14:37:35.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:176:0)
[14:37:35.014] Timer tick, asking Buildbucket for the build status
[14:37:35.226] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:35.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:177:0) after 1m0s
[14:38:35.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:177:0)
[14:38:35.289] Timer tick, asking Buildbucket for the build status
[14:38:35.795] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:35.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:178:0) after 1m0s
[14:39:35.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:178:0)
[14:39:35.809] Timer tick, asking Buildbucket for the build status
[14:39:35.899] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:35.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:179:0) after 1m0s
[14:40:35.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:179:0)
[14:40:35.942] Timer tick, asking Buildbucket for the build status
[14:40:36.058] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:36.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:180:0) after 1m0s
[14:41:36.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:180:0)
[14:41:36.105] Timer tick, asking Buildbucket for the build status
[14:41:36.217] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:36.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:181:0) after 1m0s
[14:42:36.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:181:0)
[14:42:36.298] Timer tick, asking Buildbucket for the build status
[14:42:36.531] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:36.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:182:0) after 1m0s
[14:43:36.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:182:0)
[14:43:36.596] Timer tick, asking Buildbucket for the build status
[14:43:36.691] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:36.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:183:0) after 1m0s
[14:44:36.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:183:0)
[14:44:36.772] Timer tick, asking Buildbucket for the build status
[14:44:36.889] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:36.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:184:0) after 1m0s
[14:45:38.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:184:0)
[14:45:38.049] Timer tick, asking Buildbucket for the build status
[14:45:38.211] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:38.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:185:0) after 1m0s
[14:46:38.269] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:185:0)
[14:46:38.269] Timer tick, asking Buildbucket for the build status
[14:46:38.340] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:38.340] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:186:0) after 1m0s
[14:47:38.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:186:0)
[14:47:38.404] Timer tick, asking Buildbucket for the build status
[14:47:38.483] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:38.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:187:0) after 1m0s
[14:48:38.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:187:0)
[14:48:38.560] Timer tick, asking Buildbucket for the build status
[14:48:38.674] Build 8863748492650900992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:38.674] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029178554648452768:188:0) after 1m0s
[14:49:26.759] Received PubSub notification, asking Buildbucket for the build status
[14:49:26.841] Build 8863748492650900992: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:49:26.841] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1605278965566797",
    "created_by": "project:infra",
    "created_ts": "1605267737682814",
    "id": "8863748492650900992",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4323.4\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"51a2028b-2890-4fde-932a-20befcd04f79\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4323.4\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_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-jm3o\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1605267793590784",
    "status": "COMPLETED",
    "status_changed_ts": "1605278966167881",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9029178554648452768",
      "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/8863748492650900992/+/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:4fda3b56e80ff910",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1605278966243584",
    "url": "https://ci.chromium.org/b/8863748492650900992",
    "utcnow_ts": "1605278966832985"
  }
}
[14:49:26.841] Invocation finished in 3h7m10.44749556s with status SUCCEEDED