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

• parent_buildername:publish_tarball
• user_agent:recipe

[20:03:31.057] New invocation is queued and will start shortly
[20:03:31.057] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[20:03:33.882] Starting the invocation (attempt 1)
[20:03:33.941] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:03:33.941] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:03:33.941] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9036757164275457728",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4240.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"b311902e-8882-472a-930e-e5728ea12c36\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4240.2\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9036757164275457728",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[20:03:36.796] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1598040215883156",
    "id": "8871327098548057056",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4240.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"b311902e-8882-472a-930e-e5728ea12c36\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4240.2\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1598040216419819",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9036757164275457728",
      "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/8871327098548057056/+/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": "1598040216419991",
    "url": "https://ci.chromium.org/b/8871327098548057056",
    "utcnow_ts": "1598040216651502"
  }
}
[20:03:36.796] Task URL: https://ci.chromium.org/b/8871327098548057056
[20:03:36.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:2:0) after 1m0s
[20:04:20.185] Received PubSub notification, asking Buildbucket for the build status
[20:04:20.623] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:37.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:2:0)
[20:04:37.001] Timer tick, asking Buildbucket for the build status
[20:04:37.251] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:37.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:4:0) after 1m0s
[20:05:37.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:4:0)
[20:05:37.450] Timer tick, asking Buildbucket for the build status
[20:05:37.600] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:37.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:5:0) after 1m0s
[20:06:37.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:5:0)
[20:06:37.795] Timer tick, asking Buildbucket for the build status
[20:06:37.883] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:37.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:6:0) after 1m0s
[20:07:37.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:6:0)
[20:07:37.987] Timer tick, asking Buildbucket for the build status
[20:07:38.289] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:38.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:7:0) after 1m0s
[20:08:38.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:7:0)
[20:08:38.397] Timer tick, asking Buildbucket for the build status
[20:08:38.649] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:38.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:8:0) after 1m0s
[20:09:38.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:8:0)
[20:09:38.690] Timer tick, asking Buildbucket for the build status
[20:09:38.761] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:38.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:9:0) after 1m0s
[20:10:38.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:9:0)
[20:10:38.824] Timer tick, asking Buildbucket for the build status
[20:10:38.951] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:38.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:10:0) after 1m0s
[20:11:39.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:10:0)
[20:11:39.098] Timer tick, asking Buildbucket for the build status
[20:11:40.208] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:40.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:11:0) after 1m0s
[20:12:40.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:11:0)
[20:12:40.240] Timer tick, asking Buildbucket for the build status
[20:12:40.482] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:40.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:12:0) after 1m0s
[20:13:40.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:12:0)
[20:13:40.568] Timer tick, asking Buildbucket for the build status
[20:13:40.909] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:40.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:13:0) after 1m0s
[20:14:40.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:13:0)
[20:14:40.945] Timer tick, asking Buildbucket for the build status
[20:14:41.083] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:41.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:14:0) after 1m0s
[20:15:41.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:14:0)
[20:15:41.091] Timer tick, asking Buildbucket for the build status
[20:15:41.285] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:41.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:15:0) after 1m0s
[20:16:41.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:15:0)
[20:16:41.319] Timer tick, asking Buildbucket for the build status
[20:16:41.468] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:41.468] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:16:0) after 1m0s
[20:17:41.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:16:0)
[20:17:41.493] Timer tick, asking Buildbucket for the build status
[20:17:41.715] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:41.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:17:0) after 1m0s
[20:18:41.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:17:0)
[20:18:41.734] Timer tick, asking Buildbucket for the build status
[20:18:41.839] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:41.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:18:0) after 1m0s
[20:19:41.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:18:0)
[20:19:41.878] Timer tick, asking Buildbucket for the build status
[20:19:41.947] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:41.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:19:0) after 1m0s
[20:20:41.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:19:0)
[20:20:41.975] Timer tick, asking Buildbucket for the build status
[20:20:42.075] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:42.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:20:0) after 1m0s
[20:21:42.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:20:0)
[20:21:42.095] Timer tick, asking Buildbucket for the build status
[20:21:42.227] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:42.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:21:0) after 1m0s
[20:22:42.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:21:0)
[20:22:42.240] Timer tick, asking Buildbucket for the build status
[20:22:42.406] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:42.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:22:0) after 1m0s
[20:23:42.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:22:0)
[20:23:42.588] Timer tick, asking Buildbucket for the build status
[20:23:42.747] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:42.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:23:0) after 1m0s
[20:24:43.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:23:0)
[20:24:43.115] Timer tick, asking Buildbucket for the build status
[20:24:43.214] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:43.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:24:0) after 1m0s
[20:25:43.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:24:0)
[20:25:43.308] Timer tick, asking Buildbucket for the build status
[20:25:43.379] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:43.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:25:0) after 1m0s
[20:26:43.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:25:0)
[20:26:43.522] Timer tick, asking Buildbucket for the build status
[20:26:43.577] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:43.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:26:0) after 1m0s
[20:27:43.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:26:0)
[20:27:43.766] Timer tick, asking Buildbucket for the build status
[20:27:43.905] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:43.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:27:0) after 1m0s
[20:28:44.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:27:0)
[20:28:44.034] Timer tick, asking Buildbucket for the build status
[20:28:44.162] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:44.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:28:0) after 1m0s
[20:29:44.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:28:0)
[20:29:44.240] Timer tick, asking Buildbucket for the build status
[20:29:44.313] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:44.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:29:0) after 1m0s
[20:30:44.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:29:0)
[20:30:44.371] Timer tick, asking Buildbucket for the build status
[20:30:44.594] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:44.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:30:0) after 1m0s
[20:31:44.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:30:0)
[20:31:44.639] Timer tick, asking Buildbucket for the build status
[20:31:44.893] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:44.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:31:0) after 1m0s
[20:32:44.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:31:0)
[20:32:44.878] Timer tick, asking Buildbucket for the build status
[20:32:45.091] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:45.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:32:0) after 1m0s
[20:33:45.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:32:0)
[20:33:45.194] Timer tick, asking Buildbucket for the build status
[20:33:45.448] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:45.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:33:0) after 1m0s
[20:34:45.501] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:33:0)
[20:34:45.501] Timer tick, asking Buildbucket for the build status
[20:34:45.568] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:45.568] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:34:0) after 1m0s
[20:35:45.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:34:0)
[20:35:45.667] Timer tick, asking Buildbucket for the build status
[20:35:45.883] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:45.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:35:0) after 1m0s
[20:36:45.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:35:0)
[20:36:45.961] Timer tick, asking Buildbucket for the build status
[20:36:46.128] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:46.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:36:0) after 1m0s
[20:37:46.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:36:0)
[20:37:46.199] Timer tick, asking Buildbucket for the build status
[20:37:46.280] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:46.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:37:0) after 1m0s
[20:38:46.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:37:0)
[20:38:46.382] Timer tick, asking Buildbucket for the build status
[20:38:46.528] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:46.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:38:0) after 1m0s
[20:39:46.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:38:0)
[20:39:46.532] Timer tick, asking Buildbucket for the build status
[20:39:49.262] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:49.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:39:0) after 1m0s
[20:40:49.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:39:0)
[20:40:49.307] Timer tick, asking Buildbucket for the build status
[20:40:49.490] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:49.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:40:0) after 1m0s
[20:41:49.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:40:0)
[20:41:49.518] Timer tick, asking Buildbucket for the build status
[20:41:49.700] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:49.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:41:0) after 1m0s
[20:42:49.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:41:0)
[20:42:49.806] Timer tick, asking Buildbucket for the build status
[20:42:49.912] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:49.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:42:0) after 1m0s
[20:43:49.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:42:0)
[20:43:49.962] Timer tick, asking Buildbucket for the build status
[20:43:50.135] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:50.135] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:43:0) after 1m0s
[20:44:50.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:43:0)
[20:44:50.146] Timer tick, asking Buildbucket for the build status
[20:44:50.221] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:50.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:44:0) after 1m0s
[20:45:50.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:44:0)
[20:45:50.347] Timer tick, asking Buildbucket for the build status
[20:45:50.599] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:50.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:45:0) after 1m0s
[20:46:50.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:45:0)
[20:46:50.601] Timer tick, asking Buildbucket for the build status
[20:46:50.708] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:50.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:46:0) after 1m0s
[20:47:50.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:46:0)
[20:47:50.744] Timer tick, asking Buildbucket for the build status
[20:47:50.970] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:50.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:47:0) after 1m0s
[20:48:50.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:47:0)
[20:48:50.995] Timer tick, asking Buildbucket for the build status
[20:48:51.418] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:51.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:48:0) after 1m0s
[20:49:51.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:48:0)
[20:49:51.488] Timer tick, asking Buildbucket for the build status
[20:49:51.571] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:51.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:49:0) after 1m0s
[20:50:51.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:49:0)
[20:50:51.633] Timer tick, asking Buildbucket for the build status
[20:50:53.005] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:53.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:50:0) after 1m0s
[20:51:53.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:50:0)
[20:51:53.027] Timer tick, asking Buildbucket for the build status
[20:51:53.286] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:53.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:51:0) after 1m0s
[20:52:53.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:51:0)
[20:52:53.297] Timer tick, asking Buildbucket for the build status
[20:52:53.371] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:53.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:52:0) after 1m0s
[20:53:53.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:52:0)
[20:53:53.448] Timer tick, asking Buildbucket for the build status
[20:53:53.707] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:53.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:53:0) after 1m0s
[20:54:53.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:53:0)
[20:54:53.857] Timer tick, asking Buildbucket for the build status
[20:54:54.407] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:54.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:54:0) after 1m0s
[20:55:54.504] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:54:0)
[20:55:54.504] Timer tick, asking Buildbucket for the build status
[20:55:54.576] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:54.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:55:0) after 1m0s
[20:56:54.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:55:0)
[20:56:54.608] Timer tick, asking Buildbucket for the build status
[20:56:54.816] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:54.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:56:0) after 1m0s
[20:57:54.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:56:0)
[20:57:54.895] Timer tick, asking Buildbucket for the build status
[20:57:55.672] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:55.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:57:0) after 1m0s
[20:58:55.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:57:0)
[20:58:55.753] Timer tick, asking Buildbucket for the build status
[20:58:55.894] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:55.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:58:0) after 1m0s
[20:59:55.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:58:0)
[20:59:55.904] Timer tick, asking Buildbucket for the build status
[20:59:55.969] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:55.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:59:0) after 1m0s
[21:00:55.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:59:0)
[21:00:55.991] Timer tick, asking Buildbucket for the build status
[21:00:56.068] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:56.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:60:0) after 1m0s
[21:01:56.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:60:0)
[21:01:56.156] Timer tick, asking Buildbucket for the build status
[21:01:56.263] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:56.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:61:0) after 1m0s
[21:02:56.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:61:0)
[21:02:56.272] Timer tick, asking Buildbucket for the build status
[21:02:56.396] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:56.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:62:0) after 1m0s
[21:03:56.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:62:0)
[21:03:56.440] Timer tick, asking Buildbucket for the build status
[21:03:56.610] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:56.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:63:0) after 1m0s
[21:04:56.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:63:0)
[21:04:56.659] Timer tick, asking Buildbucket for the build status
[21:04:56.794] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:56.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:64:0) after 1m0s
[21:05:56.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:64:0)
[21:05:56.803] Timer tick, asking Buildbucket for the build status
[21:05:56.871] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:56.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:65:0) after 1m0s
[21:06:56.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:65:0)
[21:06:56.896] Timer tick, asking Buildbucket for the build status
[21:06:57.033] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:57.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:66:0) after 1m0s
[21:07:57.081] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:66:0)
[21:07:57.081] Timer tick, asking Buildbucket for the build status
[21:07:57.151] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:57.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:67:0) after 1m0s
[21:08:57.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:67:0)
[21:08:57.274] Timer tick, asking Buildbucket for the build status
[21:08:57.587] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:57.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:68:0) after 1m0s
[21:09:57.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:68:0)
[21:09:57.594] Timer tick, asking Buildbucket for the build status
[21:09:57.733] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:57.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:69:0) after 1m0s
[21:10:57.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:69:0)
[21:10:57.756] Timer tick, asking Buildbucket for the build status
[21:10:57.823] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:57.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:70:0) after 1m0s
[21:11:57.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:70:0)
[21:11:57.854] Timer tick, asking Buildbucket for the build status
[21:11:57.925] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:57.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:71:0) after 1m0s
[21:12:57.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:71:0)
[21:12:57.951] Timer tick, asking Buildbucket for the build status
[21:12:58.034] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:58.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:72:0) after 1m0s
[21:13:58.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:72:0)
[21:13:58.129] Timer tick, asking Buildbucket for the build status
[21:13:58.272] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:58.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:73:0) after 1m0s
[21:14:58.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:73:0)
[21:14:58.322] Timer tick, asking Buildbucket for the build status
[21:14:58.413] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:58.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:74:0) after 1m0s
[21:15:58.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:74:0)
[21:15:58.574] Timer tick, asking Buildbucket for the build status
[21:15:59.262] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:59.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:75:0) after 1m0s
[21:16:59.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:75:0)
[21:16:59.311] Timer tick, asking Buildbucket for the build status
[21:16:59.442] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:59.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:76:0) after 1m0s
[21:17:59.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:76:0)
[21:17:59.483] Timer tick, asking Buildbucket for the build status
[21:17:59.613] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:59.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:77:0) after 1m0s
[21:18:59.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:77:0)
[21:18:59.634] Timer tick, asking Buildbucket for the build status
[21:19:00.413] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:00.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:78:0) after 1m0s
[21:20:01.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:78:0)
[21:20:01.825] Timer tick, asking Buildbucket for the build status
[21:20:02.806] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:02.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:79:0) after 1m0s
[21:21:02.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:79:0)
[21:21:02.806] Timer tick, asking Buildbucket for the build status
[21:21:02.982] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:02.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:80:0) after 1m0s
[21:22:03.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:80:0)
[21:22:03.029] Timer tick, asking Buildbucket for the build status
[21:22:03.372] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:03.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:81:0) after 1m0s
[21:23:03.360] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:81:0)
[21:23:03.360] Timer tick, asking Buildbucket for the build status
[21:23:03.470] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:03.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:82:0) after 1m0s
[21:24:03.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:82:0)
[21:24:03.538] Timer tick, asking Buildbucket for the build status
[21:24:03.881] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:03.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:83:0) after 1m0s
[21:25:03.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:83:0)
[21:25:03.905] Timer tick, asking Buildbucket for the build status
[21:25:04.261] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:04.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:84:0) after 1m0s
[21:26:04.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:84:0)
[21:26:04.299] Timer tick, asking Buildbucket for the build status
[21:26:04.997] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:04.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:85:0) after 1m0s
[21:27:05.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:85:0)
[21:27:05.059] Timer tick, asking Buildbucket for the build status
[21:27:05.125] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:05.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:86:0) after 1m0s
[21:28:05.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:86:0)
[21:28:05.153] Timer tick, asking Buildbucket for the build status
[21:28:08.620] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:08.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:87:0) after 1m0s
[21:29:08.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:87:0)
[21:29:08.702] Timer tick, asking Buildbucket for the build status
[21:29:08.873] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:08.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:88:0) after 1m0s
[21:30:08.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:88:0)
[21:30:08.969] Timer tick, asking Buildbucket for the build status
[21:30:09.713] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:09.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:89:0) after 1m0s
[21:31:09.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:89:0)
[21:31:09.788] Timer tick, asking Buildbucket for the build status
[21:31:10.224] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:10.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:90:0) after 1m0s
[21:32:10.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:90:0)
[21:32:10.286] Timer tick, asking Buildbucket for the build status
[21:32:10.344] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:10.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:91:0) after 1m0s
[21:33:10.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:91:0)
[21:33:10.433] Timer tick, asking Buildbucket for the build status
[21:33:10.537] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:10.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:92:0) after 1m0s
[21:34:10.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:92:0)
[21:34:10.588] Timer tick, asking Buildbucket for the build status
[21:34:10.731] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:10.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:93:0) after 1m0s
[21:35:10.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:93:0)
[21:35:10.806] Timer tick, asking Buildbucket for the build status
[21:35:10.898] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:10.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:94:0) after 1m0s
[21:36:10.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:94:0)
[21:36:10.889] Timer tick, asking Buildbucket for the build status
[21:36:11.125] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:11.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:95:0) after 1m0s
[21:37:11.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:95:0)
[21:37:11.181] Timer tick, asking Buildbucket for the build status
[21:37:11.277] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:11.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:96:0) after 1m0s
[21:38:11.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:96:0)
[21:38:11.308] Timer tick, asking Buildbucket for the build status
[21:38:11.382] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:11.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:97:0) after 1m0s
[21:39:11.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:97:0)
[21:39:11.441] Timer tick, asking Buildbucket for the build status
[21:39:11.816] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:11.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:98:0) after 1m0s
[21:40:11.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:98:0)
[21:40:11.848] Timer tick, asking Buildbucket for the build status
[21:40:11.942] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:11.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:99:0) after 1m0s
[21:41:11.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:99:0)
[21:41:11.971] Timer tick, asking Buildbucket for the build status
[21:41:12.049] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:12.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:100:0) after 1m0s
[21:42:12.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:100:0)
[21:42:12.067] Timer tick, asking Buildbucket for the build status
[21:42:12.505] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:12.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:101:0) after 1m0s
[21:43:12.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:101:0)
[21:43:12.529] Timer tick, asking Buildbucket for the build status
[21:43:12.623] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:12.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:102:0) after 1m0s
[21:44:12.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:102:0)
[21:44:12.709] Timer tick, asking Buildbucket for the build status
[21:44:13.025] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:13.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:103:0) after 1m0s
[21:45:13.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:103:0)
[21:45:13.102] Timer tick, asking Buildbucket for the build status
[21:45:13.722] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:13.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:104:0) after 1m0s
[21:46:13.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:104:0)
[21:46:13.762] Timer tick, asking Buildbucket for the build status
[21:46:13.902] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:13.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:105:0) after 1m0s
[21:47:13.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:105:0)
[21:47:13.900] Timer tick, asking Buildbucket for the build status
[21:47:13.981] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:13.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:106:0) after 1m0s
[21:48:14.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:106:0)
[21:48:14.005] Timer tick, asking Buildbucket for the build status
[21:48:14.090] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:14.090] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:107:0) after 1m0s
[21:49:14.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:107:0)
[21:49:14.149] Timer tick, asking Buildbucket for the build status
[21:49:14.283] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:14.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:108:0) after 1m0s
[21:50:14.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:108:0)
[21:50:14.359] Timer tick, asking Buildbucket for the build status
[21:50:14.496] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:14.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:109:0) after 1m0s
[21:51:14.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:109:0)
[21:51:14.548] Timer tick, asking Buildbucket for the build status
[21:51:14.629] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:14.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:110:0) after 1m0s
[21:52:14.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:110:0)
[21:52:14.743] Timer tick, asking Buildbucket for the build status
[21:52:14.815] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:14.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:111:0) after 1m0s
[21:53:14.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:111:0)
[21:53:14.989] Timer tick, asking Buildbucket for the build status
[21:53:15.095] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:15.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:112:0) after 1m0s
[21:54:15.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:112:0)
[21:54:15.164] Timer tick, asking Buildbucket for the build status
[21:54:15.282] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:15.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:113:0) after 1m0s
[21:55:15.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:113:0)
[21:55:15.422] Timer tick, asking Buildbucket for the build status
[21:55:15.496] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:15.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:114:0) after 1m0s
[21:56:15.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:114:0)
[21:56:15.808] Timer tick, asking Buildbucket for the build status
[21:56:15.922] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:15.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:115:0) after 1m0s
[21:57:15.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:115:0)
[21:57:15.988] Timer tick, asking Buildbucket for the build status
[21:57:17.538] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:17.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:116:0) after 1m0s
[21:58:17.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:116:0)
[21:58:17.711] Timer tick, asking Buildbucket for the build status
[21:58:17.813] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:17.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:117:0) after 1m0s
[21:59:17.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:117:0)
[21:59:17.860] Timer tick, asking Buildbucket for the build status
[21:59:18.020] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:18.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:118:0) after 1m0s
[22:00:18.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:118:0)
[22:00:18.087] Timer tick, asking Buildbucket for the build status
[22:00:18.168] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:18.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:119:0) after 1m0s
[22:01:18.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:119:0)
[22:01:18.259] Timer tick, asking Buildbucket for the build status
[22:01:18.362] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:18.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:120:0) after 1m0s
[22:02:18.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:120:0)
[22:02:18.457] Timer tick, asking Buildbucket for the build status
[22:02:18.518] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:18.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:121:0) after 1m0s
[22:03:18.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:121:0)
[22:03:18.640] Timer tick, asking Buildbucket for the build status
[22:03:18.901] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:18.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:122:0) after 1m0s
[22:04:19.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:122:0)
[22:04:19.037] Timer tick, asking Buildbucket for the build status
[22:04:19.155] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:19.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:123:0) after 1m0s
[22:05:19.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:123:0)
[22:05:19.167] Timer tick, asking Buildbucket for the build status
[22:05:19.304] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:19.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:124:0) after 1m0s
[22:06:19.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:124:0)
[22:06:19.374] Timer tick, asking Buildbucket for the build status
[22:06:19.448] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:19.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:125:0) after 1m0s
[22:07:19.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:125:0)
[22:07:19.527] Timer tick, asking Buildbucket for the build status
[22:07:19.608] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:19.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:126:0) after 1m0s
[22:08:19.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:126:0)
[22:08:19.859] Timer tick, asking Buildbucket for the build status
[22:08:20.148] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:20.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:127:0) after 1m0s
[22:09:20.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:127:0)
[22:09:20.212] Timer tick, asking Buildbucket for the build status
[22:09:20.378] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:20.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:128:0) after 1m0s
[22:10:20.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:128:0)
[22:10:20.607] Timer tick, asking Buildbucket for the build status
[22:10:20.688] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:20.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:129:0) after 1m0s
[22:11:20.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:129:0)
[22:11:20.771] Timer tick, asking Buildbucket for the build status
[22:11:21.100] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:21.100] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:130:0) after 1m0s
[22:12:21.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:130:0)
[22:12:21.177] Timer tick, asking Buildbucket for the build status
[22:12:21.252] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:21.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:131:0) after 1m0s
[22:13:21.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:131:0)
[22:13:21.346] Timer tick, asking Buildbucket for the build status
[22:13:21.411] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:21.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:132:0) after 1m0s
[22:14:21.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:132:0)
[22:14:21.457] Timer tick, asking Buildbucket for the build status
[22:14:21.739] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:21.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:133:0) after 1m0s
[22:15:21.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:133:0)
[22:15:21.860] Timer tick, asking Buildbucket for the build status
[22:15:21.955] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:21.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:134:0) after 1m0s
[22:16:22.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:134:0)
[22:16:22.987] Timer tick, asking Buildbucket for the build status
[22:16:23.042] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:23.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:135:0) after 1m0s
[22:17:23.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:135:0)
[22:17:23.179] Timer tick, asking Buildbucket for the build status
[22:17:23.268] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:23.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:136:0) after 1m0s
[22:18:23.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:136:0)
[22:18:23.334] Timer tick, asking Buildbucket for the build status
[22:18:23.406] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:23.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:137:0) after 1m0s
[22:19:23.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:137:0)
[22:19:23.448] Timer tick, asking Buildbucket for the build status
[22:19:23.708] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:23.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:138:0) after 1m0s
[22:20:23.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:138:0)
[22:20:23.751] Timer tick, asking Buildbucket for the build status
[22:20:23.904] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:23.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:139:0) after 1m0s
[22:21:23.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:139:0)
[22:21:23.898] Timer tick, asking Buildbucket for the build status
[22:21:24.566] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:24.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:140:0) after 1m0s
[22:22:24.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:140:0)
[22:22:24.614] Timer tick, asking Buildbucket for the build status
[22:22:24.831] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:24.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:141:0) after 1m0s
[22:23:24.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:141:0)
[22:23:24.871] Timer tick, asking Buildbucket for the build status
[22:23:24.943] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:24.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:142:0) after 1m0s
[22:24:24.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:142:0)
[22:24:24.973] Timer tick, asking Buildbucket for the build status
[22:24:25.131] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:25.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:143:0) after 1m0s
[22:25:25.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:143:0)
[22:25:25.195] Timer tick, asking Buildbucket for the build status
[22:25:25.261] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:25.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:144:0) after 1m0s
[22:26:25.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:144:0)
[22:26:25.337] Timer tick, asking Buildbucket for the build status
[22:26:25.420] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:25.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:145:0) after 1m0s
[22:27:25.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:145:0)
[22:27:25.473] Timer tick, asking Buildbucket for the build status
[22:27:26.032] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:26.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:146:0) after 1m0s
[22:28:26.040] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:146:0)
[22:28:26.040] Timer tick, asking Buildbucket for the build status
[22:28:26.118] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:26.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:147:0) after 1m0s
[22:29:26.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:147:0)
[22:29:26.205] Timer tick, asking Buildbucket for the build status
[22:29:26.357] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:26.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:148:0) after 1m0s
[22:30:26.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:148:0)
[22:30:26.398] Timer tick, asking Buildbucket for the build status
[22:30:27.146] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:27.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:149:0) after 1m0s
[22:31:27.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:149:0)
[22:31:27.169] Timer tick, asking Buildbucket for the build status
[22:31:27.363] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:27.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:150:0) after 1m0s
[22:32:27.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:150:0)
[22:32:27.397] Timer tick, asking Buildbucket for the build status
[22:32:27.691] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:27.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:151:0) after 1m0s
[22:33:27.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:151:0)
[22:33:27.730] Timer tick, asking Buildbucket for the build status
[22:33:27.806] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:27.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:152:0) after 1m0s
[22:34:27.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:152:0)
[22:34:27.894] Timer tick, asking Buildbucket for the build status
[22:34:27.997] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:27.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:153:0) after 1m0s
[22:35:28.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:153:0)
[22:35:28.017] Timer tick, asking Buildbucket for the build status
[22:35:31.389] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:31.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:154:0) after 1m0s
[22:36:31.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:154:0)
[22:36:31.415] Timer tick, asking Buildbucket for the build status
[22:36:31.906] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:31.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:155:0) after 1m0s
[22:37:31.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:155:0)
[22:37:31.930] Timer tick, asking Buildbucket for the build status
[22:37:32.054] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:32.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:156:0) after 1m0s
[22:38:32.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:156:0)
[22:38:32.092] Timer tick, asking Buildbucket for the build status
[22:38:32.639] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:32.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:157:0) after 1m0s
[22:39:32.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:157:0)
[22:39:32.695] Timer tick, asking Buildbucket for the build status
[22:39:32.943] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:32.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:158:0) after 1m0s
[22:40:32.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:158:0)
[22:40:32.977] Timer tick, asking Buildbucket for the build status
[22:40:33.052] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:33.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:159:0) after 1m0s
[22:41:33.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:159:0)
[22:41:33.099] Timer tick, asking Buildbucket for the build status
[22:41:33.244] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:33.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:160:0) after 1m0s
[22:42:33.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:160:0)
[22:42:33.275] Timer tick, asking Buildbucket for the build status
[22:42:33.353] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:33.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:161:0) after 1m0s
[22:43:33.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:161:0)
[22:43:33.444] Timer tick, asking Buildbucket for the build status
[22:43:33.619] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:33.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:162:0) after 1m0s
[22:44:33.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:162:0)
[22:44:33.679] Timer tick, asking Buildbucket for the build status
[22:44:34.324] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:34.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:163:0) after 1m0s
[22:45:34.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:163:0)
[22:45:34.363] Timer tick, asking Buildbucket for the build status
[22:45:35.127] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:35.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:164:0) after 1m0s
[22:46:35.229] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:164:0)
[22:46:35.229] Timer tick, asking Buildbucket for the build status
[22:46:35.292] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:35.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:165:0) after 1m0s
[22:47:35.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:165:0)
[22:47:35.379] Timer tick, asking Buildbucket for the build status
[22:47:35.449] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:35.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:166:0) after 1m0s
[22:48:35.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:166:0)
[22:48:35.493] Timer tick, asking Buildbucket for the build status
[22:48:36.152] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:36.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:167:0) after 1m0s
[22:49:36.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:167:0)
[22:49:36.223] Timer tick, asking Buildbucket for the build status
[22:49:36.542] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:36.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:168:0) after 1m0s
[22:50:36.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:168:0)
[22:50:36.622] Timer tick, asking Buildbucket for the build status
[22:50:36.687] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:36.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:169:0) after 1m0s
[22:51:36.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:169:0)
[22:51:36.715] Timer tick, asking Buildbucket for the build status
[22:51:36.809] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:36.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:170:0) after 1m0s
[22:52:36.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:170:0)
[22:52:36.871] Timer tick, asking Buildbucket for the build status
[22:52:36.961] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:36.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:171:0) after 1m0s
[22:53:36.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:171:0)
[22:53:36.989] Timer tick, asking Buildbucket for the build status
[22:53:37.064] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:37.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:172:0) after 1m0s
[22:54:37.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:172:0)
[22:54:37.206] Timer tick, asking Buildbucket for the build status
[22:54:37.679] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:37.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:173:0) after 1m0s
[22:55:37.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:173:0)
[22:55:37.712] Timer tick, asking Buildbucket for the build status
[22:55:37.920] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:37.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:174:0) after 1m0s
[22:56:37.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:174:0)
[22:56:37.934] Timer tick, asking Buildbucket for the build status
[22:56:38.174] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:38.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:175:0) after 1m0s
[22:57:38.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:175:0)
[22:57:38.203] Timer tick, asking Buildbucket for the build status
[22:57:38.299] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:38.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:176:0) after 1m0s
[22:58:38.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:176:0)
[22:58:38.370] Timer tick, asking Buildbucket for the build status
[22:58:38.436] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:38.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:177:0) after 1m0s
[22:59:38.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:177:0)
[22:59:38.474] Timer tick, asking Buildbucket for the build status
[22:59:41.972] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:41.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:178:0) after 1m0s
[23:00:42.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:178:0)
[23:00:42.049] Timer tick, asking Buildbucket for the build status
[23:00:42.142] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:42.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:179:0) after 1m0s
[23:01:42.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:179:0)
[23:01:42.237] Timer tick, asking Buildbucket for the build status
[23:01:42.320] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:42.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:180:0) after 1m0s
[23:02:42.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:180:0)
[23:02:42.423] Timer tick, asking Buildbucket for the build status
[23:02:42.650] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:42.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:181:0) after 1m0s
[23:03:42.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:181:0)
[23:03:42.681] Timer tick, asking Buildbucket for the build status
[23:03:42.790] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:42.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:182:0) after 1m0s
[23:04:42.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:182:0)
[23:04:42.868] Timer tick, asking Buildbucket for the build status
[23:04:43.019] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:43.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:183:0) after 1m0s
[23:05:43.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:183:0)
[23:05:43.045] Timer tick, asking Buildbucket for the build status
[23:05:43.154] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:43.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:184:0) after 1m0s
[23:06:43.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:184:0)
[23:06:43.206] Timer tick, asking Buildbucket for the build status
[23:06:43.419] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:43.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:185:0) after 1m0s
[23:07:43.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:185:0)
[23:07:43.476] Timer tick, asking Buildbucket for the build status
[23:07:43.735] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:43.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:186:0) after 1m0s
[23:08:43.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:186:0)
[23:08:43.774] Timer tick, asking Buildbucket for the build status
[23:08:43.877] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:43.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:187:0) after 1m0s
[23:09:43.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:187:0)
[23:09:43.928] Timer tick, asking Buildbucket for the build status
[23:09:44.062] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:44.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:188:0) after 1m0s
[23:10:44.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:188:0)
[23:10:44.150] Timer tick, asking Buildbucket for the build status
[23:10:44.248] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:44.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:189:0) after 1m0s
[23:11:44.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:189:0)
[23:11:44.240] Timer tick, asking Buildbucket for the build status
[23:11:44.342] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:44.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:190:0) after 1m0s
[23:12:44.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:190:0)
[23:12:44.377] Timer tick, asking Buildbucket for the build status
[23:12:44.488] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:44.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:191:0) after 1m0s
[23:13:44.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:191:0)
[23:13:44.577] Timer tick, asking Buildbucket for the build status
[23:13:44.715] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:44.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:192:0) after 1m0s
[23:14:44.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:192:0)
[23:14:44.773] Timer tick, asking Buildbucket for the build status
[23:14:44.965] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:44.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:193:0) after 1m0s
[23:15:45.019] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:193:0)
[23:15:45.019] Timer tick, asking Buildbucket for the build status
[23:15:45.133] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:45.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:194:0) after 1m0s
[23:16:45.136] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:194:0)
[23:16:45.136] Timer tick, asking Buildbucket for the build status
[23:16:45.295] Build 8871327098548057056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:45.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036757164275457728:195:0) after 1m0s
[23:17:03.209] Received PubSub notification, asking Buildbucket for the build status
[23:17:03.280] Build 8871327098548057056: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:17:03.280] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1598051822262546",
    "created_by": "project:infra",
    "created_ts": "1598040215883156",
    "id": "8871327098548057056",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4240.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"b311902e-8882-472a-930e-e5728ea12c36\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4240.2\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-wu28\"], \"image\": [\"chrome-xenial-20081700-d9392568d25\"], \"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\": [\"5498-3454aa6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1598040258489391",
    "status": "COMPLETED",
    "status_changed_ts": "1598051822753431",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9036757164275457728",
      "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/8871327098548057056/+/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:4e2b701d061f8710",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1598051822799852",
    "url": "https://ci.chromium.org/b/8871327098548057056",
    "utcnow_ts": "1598051823269435"
  }
}
[23:17:03.280] Invocation finished in 3h13m32.242739224s with status SUCCEEDED