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

• parent_buildername:publish_tarball
• user_agent:recipe

[09:07:10.769] New invocation is queued and will start shortly
[09:07:10.769] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[09:07:11.984] Starting the invocation (attempt 1)
[09:07:12.023] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:07:12.023] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:07:12.023] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9049391435825702048",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"84.0.4104.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"a12c8cc0-45ed-4710-8c8a-074530e9ffa3\",\"title\":\"publish_tarball/0\"}]},\"version\":\"84.0.4104.0\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9049391435825702048",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[09:07:12.948] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1585991232135584",
    "id": "8883961373730948336",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4104.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"a12c8cc0-45ed-4710-8c8a-074530e9ffa3\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4104.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1585991232650276",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9049391435825702048",
      "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/8883961373730948336/+/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": "1585991232650417",
    "url": "https://ci.chromium.org/b/8883961373730948336",
    "utcnow_ts": "1585991232938367"
  }
}
[09:07:12.948] Task URL: https://ci.chromium.org/b/8883961373730948336
[09:07:12.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:2:0) after 1m0s
[09:08:13.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:2:0)
[09:08:13.116] Timer tick, asking Buildbucket for the build status
[09:08:13.283] Build 8883961373730948336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:08:13.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:3:0) after 1m0s
[09:09:13.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:3:0)
[09:09:13.615] Timer tick, asking Buildbucket for the build status
[09:09:14.072] Build 8883961373730948336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:09:14.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:4:0) after 1m0s
[09:10:14.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:4:0)
[09:10:14.369] Timer tick, asking Buildbucket for the build status
[09:10:14.567] Build 8883961373730948336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:10:14.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:5:0) after 1m0s
[09:11:14.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:5:0)
[09:11:14.780] Timer tick, asking Buildbucket for the build status
[09:11:15.047] Build 8883961373730948336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:11:15.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:6:0) after 1m0s
[09:12:15.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:6:0)
[09:12:15.270] Timer tick, asking Buildbucket for the build status
[09:12:15.396] Build 8883961373730948336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:12:15.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:7:0) after 1m0s
[09:13:15.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:7:0)
[09:13:15.528] Timer tick, asking Buildbucket for the build status
[09:13:15.649] Build 8883961373730948336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:13:15.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:8:0) after 1m0s
[09:14:15.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:8:0)
[09:14:15.947] Timer tick, asking Buildbucket for the build status
[09:14:16.095] Build 8883961373730948336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:14:16.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:9:0) after 1m0s
[09:15:16.229] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:9:0)
[09:15:16.229] Timer tick, asking Buildbucket for the build status
[09:15:16.442] Build 8883961373730948336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:15:16.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:10:0) after 1m0s
[09:16:16.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:10:0)
[09:16:16.675] Timer tick, asking Buildbucket for the build status
[09:16:16.826] Build 8883961373730948336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:16:16.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:11:0) after 1m0s
[09:17:16.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:11:0)
[09:17:16.854] Timer tick, asking Buildbucket for the build status
[09:17:16.988] Build 8883961373730948336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:17:16.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:12:0) after 1m0s
[09:17:36.492] Received PubSub notification, asking Buildbucket for the build status
[09:17:36.660] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:17.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:12:0)
[09:18:17.168] Timer tick, asking Buildbucket for the build status
[09:18:17.342] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:17.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:14:0) after 1m0s
[09:19:17.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:14:0)
[09:19:17.474] Timer tick, asking Buildbucket for the build status
[09:19:17.634] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:17.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:15:0) after 1m0s
[09:20:17.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:15:0)
[09:20:17.846] Timer tick, asking Buildbucket for the build status
[09:20:18.007] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:18.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:16:0) after 1m0s
[09:21:18.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:16:0)
[09:21:18.028] Timer tick, asking Buildbucket for the build status
[09:21:18.258] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:18.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:17:0) after 1m0s
[09:22:18.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:17:0)
[09:22:18.388] Timer tick, asking Buildbucket for the build status
[09:22:18.784] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:18.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:18:0) after 1m0s
[09:23:18.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:18:0)
[09:23:18.825] Timer tick, asking Buildbucket for the build status
[09:23:19.156] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:19.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:19:0) after 1m0s
[09:24:19.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:19:0)
[09:24:19.191] Timer tick, asking Buildbucket for the build status
[09:24:19.384] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:19.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:20:0) after 1m0s
[09:25:19.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:20:0)
[09:25:19.556] Timer tick, asking Buildbucket for the build status
[09:25:19.712] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:19.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:21:0) after 1m0s
[09:26:19.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:21:0)
[09:26:19.731] Timer tick, asking Buildbucket for the build status
[09:26:20.149] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:20.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:22:0) after 1m0s
[09:27:20.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:22:0)
[09:27:20.298] Timer tick, asking Buildbucket for the build status
[09:27:20.560] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:20.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:23:0) after 1m0s
[09:28:20.630] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:23:0)
[09:28:20.630] Timer tick, asking Buildbucket for the build status
[09:28:21.485] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:21.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:24:0) after 1m0s
[09:29:21.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:24:0)
[09:29:21.518] Timer tick, asking Buildbucket for the build status
[09:29:21.653] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:21.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:25:0) after 1m0s
[09:30:21.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:25:0)
[09:30:21.996] Timer tick, asking Buildbucket for the build status
[09:30:22.171] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:22.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:26:0) after 1m0s
[09:31:22.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:26:0)
[09:31:22.194] Timer tick, asking Buildbucket for the build status
[09:31:22.340] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:22.340] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:27:0) after 1m0s
[09:32:22.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:27:0)
[09:32:22.396] Timer tick, asking Buildbucket for the build status
[09:32:22.733] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:22.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:28:0) after 1m0s
[09:33:22.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:28:0)
[09:33:22.817] Timer tick, asking Buildbucket for the build status
[09:33:23.075] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:23.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:29:0) after 1m0s
[09:34:23.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:29:0)
[09:34:23.117] Timer tick, asking Buildbucket for the build status
[09:34:23.348] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:23.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:30:0) after 1m0s
[09:35:23.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:30:0)
[09:35:23.426] Timer tick, asking Buildbucket for the build status
[09:35:23.611] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:23.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:31:0) after 1m0s
[09:36:23.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:31:0)
[09:36:23.674] Timer tick, asking Buildbucket for the build status
[09:36:23.760] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:23.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:32:0) after 1m0s
[09:37:23.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:32:0)
[09:37:23.779] Timer tick, asking Buildbucket for the build status
[09:37:23.895] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:23.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:33:0) after 1m0s
[09:38:23.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:33:0)
[09:38:23.915] Timer tick, asking Buildbucket for the build status
[09:38:24.126] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:24.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:34:0) after 1m0s
[09:39:24.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:34:0)
[09:39:24.462] Timer tick, asking Buildbucket for the build status
[09:39:24.638] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:24.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:35:0) after 1m0s
[09:40:24.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:35:0)
[09:40:24.776] Timer tick, asking Buildbucket for the build status
[09:40:26.655] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:26.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:36:0) after 1m0s
[09:41:26.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:36:0)
[09:41:26.764] Timer tick, asking Buildbucket for the build status
[09:41:26.883] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:26.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:37:0) after 1m0s
[09:42:26.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:37:0)
[09:42:26.892] Timer tick, asking Buildbucket for the build status
[09:42:27.092] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:27.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:38:0) after 1m0s
[09:43:27.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:38:0)
[09:43:27.115] Timer tick, asking Buildbucket for the build status
[09:43:27.218] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:27.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:39:0) after 1m0s
[09:44:27.310] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:39:0)
[09:44:27.310] Timer tick, asking Buildbucket for the build status
[09:44:27.380] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:27.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:40:0) after 1m0s
[09:45:27.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:40:0)
[09:45:27.603] Timer tick, asking Buildbucket for the build status
[09:45:27.764] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:27.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:41:0) after 1m0s
[09:46:27.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:41:0)
[09:46:27.942] Timer tick, asking Buildbucket for the build status
[09:46:28.083] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:28.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:42:0) after 1m0s
[09:47:28.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:42:0)
[09:47:28.196] Timer tick, asking Buildbucket for the build status
[09:47:28.551] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:28.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:43:0) after 1m0s
[09:48:28.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:43:0)
[09:48:28.616] Timer tick, asking Buildbucket for the build status
[09:48:28.757] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:28.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:44:0) after 1m0s
[09:49:28.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:44:0)
[09:49:28.829] Timer tick, asking Buildbucket for the build status
[09:49:29.170] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:29.170] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:45:0) after 1m0s
[09:50:29.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:45:0)
[09:50:29.251] Timer tick, asking Buildbucket for the build status
[09:50:29.784] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:29.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:46:0) after 1m0s
[09:51:29.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:46:0)
[09:51:29.869] Timer tick, asking Buildbucket for the build status
[09:51:30.006] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:30.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:47:0) after 1m0s
[09:52:30.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:47:0)
[09:52:30.161] Timer tick, asking Buildbucket for the build status
[09:52:30.691] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:30.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:48:0) after 1m0s
[09:53:30.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:48:0)
[09:53:30.839] Timer tick, asking Buildbucket for the build status
[09:53:31.148] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:31.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:49:0) after 1m0s
[09:54:31.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:49:0)
[09:54:31.212] Timer tick, asking Buildbucket for the build status
[09:54:31.329] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:31.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:50:0) after 1m0s
[09:55:31.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:50:0)
[09:55:31.359] Timer tick, asking Buildbucket for the build status
[09:55:31.837] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:31.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:51:0) after 1m0s
[09:56:32.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:51:0)
[09:56:32.038] Timer tick, asking Buildbucket for the build status
[09:56:32.133] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:32.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:52:0) after 1m0s
[09:57:32.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:52:0)
[09:57:32.287] Timer tick, asking Buildbucket for the build status
[09:57:32.575] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:32.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:53:0) after 1m0s
[09:58:32.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:53:0)
[09:58:32.641] Timer tick, asking Buildbucket for the build status
[09:58:32.799] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:32.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:54:0) after 1m0s
[09:59:32.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:54:0)
[09:59:32.923] Timer tick, asking Buildbucket for the build status
[09:59:33.041] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:33.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:55:0) after 1m0s
[10:00:33.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:55:0)
[10:00:33.118] Timer tick, asking Buildbucket for the build status
[10:00:33.444] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:33.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:56:0) after 1m0s
[10:01:33.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:56:0)
[10:01:33.492] Timer tick, asking Buildbucket for the build status
[10:01:33.708] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:33.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:57:0) after 1m0s
[10:02:33.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:57:0)
[10:02:33.745] Timer tick, asking Buildbucket for the build status
[10:02:34.004] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:34.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:58:0) after 1m0s
[10:03:34.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:58:0)
[10:03:34.085] Timer tick, asking Buildbucket for the build status
[10:03:34.373] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:34.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:59:0) after 1m0s
[10:04:34.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:59:0)
[10:04:34.472] Timer tick, asking Buildbucket for the build status
[10:04:34.621] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:34.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:60:0) after 1m0s
[10:05:34.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:60:0)
[10:05:34.684] Timer tick, asking Buildbucket for the build status
[10:05:35.122] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:35.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:61:0) after 1m0s
[10:06:35.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:61:0)
[10:06:35.146] Timer tick, asking Buildbucket for the build status
[10:06:35.492] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:35.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:62:0) after 1m0s
[10:07:35.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:62:0)
[10:07:35.530] Timer tick, asking Buildbucket for the build status
[10:07:36.081] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:36.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:63:0) after 1m0s
[10:08:36.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:63:0)
[10:08:36.125] Timer tick, asking Buildbucket for the build status
[10:08:36.501] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:36.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:64:0) after 1m0s
[10:09:36.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:64:0)
[10:09:36.532] Timer tick, asking Buildbucket for the build status
[10:09:37.651] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:37.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:65:0) after 1m0s
[10:10:37.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:65:0)
[10:10:37.856] Timer tick, asking Buildbucket for the build status
[10:10:38.152] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:38.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:66:0) after 1m0s
[10:11:38.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:66:0)
[10:11:38.247] Timer tick, asking Buildbucket for the build status
[10:11:38.407] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:38.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:67:0) after 1m0s
[10:12:38.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:67:0)
[10:12:38.526] Timer tick, asking Buildbucket for the build status
[10:12:39.689] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:39.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:68:0) after 1m0s
[10:13:39.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:68:0)
[10:13:39.812] Timer tick, asking Buildbucket for the build status
[10:13:39.919] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:39.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:69:0) after 1m0s
[10:14:39.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:69:0)
[10:14:39.983] Timer tick, asking Buildbucket for the build status
[10:14:40.121] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:40.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:70:0) after 1m0s
[10:15:40.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:70:0)
[10:15:40.163] Timer tick, asking Buildbucket for the build status
[10:15:40.306] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:40.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:71:0) after 1m0s
[10:16:40.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:71:0)
[10:16:40.364] Timer tick, asking Buildbucket for the build status
[10:16:40.553] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:40.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:72:0) after 1m0s
[10:17:40.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:72:0)
[10:17:40.631] Timer tick, asking Buildbucket for the build status
[10:17:40.902] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:40.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:73:0) after 1m0s
[10:18:40.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:73:0)
[10:18:40.999] Timer tick, asking Buildbucket for the build status
[10:18:41.348] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:41.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:74:0) after 1m0s
[10:19:41.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:74:0)
[10:19:41.671] Timer tick, asking Buildbucket for the build status
[10:19:41.802] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:41.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:75:0) after 1m0s
[10:20:42.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:75:0)
[10:20:42.132] Timer tick, asking Buildbucket for the build status
[10:20:42.833] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:42.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:76:0) after 1m0s
[10:21:43.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:76:0)
[10:21:43.045] Timer tick, asking Buildbucket for the build status
[10:21:43.206] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:43.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:77:0) after 1m0s
[10:22:43.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:77:0)
[10:22:43.238] Timer tick, asking Buildbucket for the build status
[10:22:43.511] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:43.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:78:0) after 1m0s
[10:23:43.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:78:0)
[10:23:43.569] Timer tick, asking Buildbucket for the build status
[10:23:43.681] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:43.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:79:0) after 1m0s
[10:24:43.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:79:0)
[10:24:43.727] Timer tick, asking Buildbucket for the build status
[10:24:43.907] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:43.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:80:0) after 1m0s
[10:25:44.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:80:0)
[10:25:44.169] Timer tick, asking Buildbucket for the build status
[10:25:44.276] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:44.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:81:0) after 1m0s
[10:26:44.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:81:0)
[10:26:44.452] Timer tick, asking Buildbucket for the build status
[10:26:44.606] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:44.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:82:0) after 1m0s
[10:27:44.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:82:0)
[10:27:44.764] Timer tick, asking Buildbucket for the build status
[10:27:44.857] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:44.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:83:0) after 1m0s
[10:28:45.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:83:0)
[10:28:45.046] Timer tick, asking Buildbucket for the build status
[10:28:45.147] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:45.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:84:0) after 1m0s
[10:29:45.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:84:0)
[10:29:45.298] Timer tick, asking Buildbucket for the build status
[10:29:45.544] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:45.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:85:0) after 1m0s
[10:30:45.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:85:0)
[10:30:45.567] Timer tick, asking Buildbucket for the build status
[10:30:45.680] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:45.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:86:0) after 1m0s
[10:31:45.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:86:0)
[10:31:45.758] Timer tick, asking Buildbucket for the build status
[10:31:46.254] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:46.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:87:0) after 1m0s
[10:32:46.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:87:0)
[10:32:46.361] Timer tick, asking Buildbucket for the build status
[10:32:47.665] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:47.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:88:0) after 1m0s
[10:33:47.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:88:0)
[10:33:47.692] Timer tick, asking Buildbucket for the build status
[10:33:47.798] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:47.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:89:0) after 1m0s
[10:34:47.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:89:0)
[10:34:47.923] Timer tick, asking Buildbucket for the build status
[10:34:48.037] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:48.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:90:0) after 1m0s
[10:35:48.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:90:0)
[10:35:48.084] Timer tick, asking Buildbucket for the build status
[10:35:48.397] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:48.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:91:0) after 1m0s
[10:36:48.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:91:0)
[10:36:48.427] Timer tick, asking Buildbucket for the build status
[10:36:48.675] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:48.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:92:0) after 1m0s
[10:37:48.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:92:0)
[10:37:48.701] Timer tick, asking Buildbucket for the build status
[10:37:48.934] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:48.934] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:93:0) after 1m0s
[10:38:48.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:93:0)
[10:38:48.961] Timer tick, asking Buildbucket for the build status
[10:38:49.122] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:49.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:94:0) after 1m0s
[10:39:49.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:94:0)
[10:39:49.164] Timer tick, asking Buildbucket for the build status
[10:39:49.696] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:49.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:95:0) after 1m0s
[10:40:49.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:95:0)
[10:40:49.732] Timer tick, asking Buildbucket for the build status
[10:40:50.155] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:50.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:96:0) after 1m0s
[10:41:50.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:96:0)
[10:41:50.195] Timer tick, asking Buildbucket for the build status
[10:41:50.369] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:50.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:97:0) after 1m0s
[10:42:50.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:97:0)
[10:42:50.393] Timer tick, asking Buildbucket for the build status
[10:42:50.521] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:50.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:98:0) after 1m0s
[10:43:50.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:98:0)
[10:43:50.540] Timer tick, asking Buildbucket for the build status
[10:43:50.747] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:50.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:99:0) after 1m0s
[10:44:50.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:99:0)
[10:44:50.770] Timer tick, asking Buildbucket for the build status
[10:44:51.079] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:51.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:100:0) after 1m0s
[10:45:51.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:100:0)
[10:45:51.063] Timer tick, asking Buildbucket for the build status
[10:45:51.465] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:51.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:101:0) after 1m0s
[10:46:51.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:101:0)
[10:46:51.580] Timer tick, asking Buildbucket for the build status
[10:46:51.760] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:51.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:102:0) after 1m0s
[10:47:51.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:102:0)
[10:47:51.811] Timer tick, asking Buildbucket for the build status
[10:47:52.125] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:52.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:103:0) after 1m0s
[10:48:52.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:103:0)
[10:48:52.247] Timer tick, asking Buildbucket for the build status
[10:48:52.372] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:52.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:104:0) after 1m0s
[10:49:52.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:104:0)
[10:49:52.407] Timer tick, asking Buildbucket for the build status
[10:49:52.529] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:52.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:105:0) after 1m0s
[10:50:52.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:105:0)
[10:50:52.580] Timer tick, asking Buildbucket for the build status
[10:50:52.704] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:52.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:106:0) after 1m0s
[10:51:52.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:106:0)
[10:51:52.798] Timer tick, asking Buildbucket for the build status
[10:51:52.911] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:52.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:107:0) after 1m0s
[10:52:53.171] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:107:0)
[10:52:53.171] Timer tick, asking Buildbucket for the build status
[10:52:53.549] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:53.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:108:0) after 1m0s
[10:53:53.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:108:0)
[10:53:53.737] Timer tick, asking Buildbucket for the build status
[10:53:53.992] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:53.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:109:0) after 1m0s
[10:54:53.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:109:0)
[10:54:53.965] Timer tick, asking Buildbucket for the build status
[10:54:54.141] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:54.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:110:0) after 1m0s
[10:55:54.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:110:0)
[10:55:54.162] Timer tick, asking Buildbucket for the build status
[10:55:54.355] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:54.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:111:0) after 1m0s
[10:56:54.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:111:0)
[10:56:54.378] Timer tick, asking Buildbucket for the build status
[10:56:54.799] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:54.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:112:0) after 1m0s
[10:57:54.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:112:0)
[10:57:54.860] Timer tick, asking Buildbucket for the build status
[10:57:55.040] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:55.040] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:113:0) after 1m0s
[10:58:55.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:113:0)
[10:58:55.074] Timer tick, asking Buildbucket for the build status
[10:58:55.301] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:55.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:114:0) after 1m0s
[10:59:55.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:114:0)
[10:59:55.327] Timer tick, asking Buildbucket for the build status
[10:59:55.431] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:55.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:115:0) after 1m0s
[11:00:55.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:115:0)
[11:00:55.471] Timer tick, asking Buildbucket for the build status
[11:00:55.592] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:55.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:116:0) after 1m0s
[11:01:55.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:116:0)
[11:01:55.571] Timer tick, asking Buildbucket for the build status
[11:01:55.854] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:55.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:117:0) after 1m0s
[11:02:55.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:117:0)
[11:02:55.955] Timer tick, asking Buildbucket for the build status
[11:02:56.304] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:56.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:118:0) after 1m0s
[11:03:56.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:118:0)
[11:03:56.432] Timer tick, asking Buildbucket for the build status
[11:03:56.556] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:56.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:119:0) after 1m0s
[11:04:56.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:119:0)
[11:04:56.581] Timer tick, asking Buildbucket for the build status
[11:04:56.899] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:56.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:120:0) after 1m0s
[11:05:56.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:120:0)
[11:05:56.929] Timer tick, asking Buildbucket for the build status
[11:05:57.087] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:57.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:121:0) after 1m0s
[11:06:57.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:121:0)
[11:06:57.116] Timer tick, asking Buildbucket for the build status
[11:06:57.495] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:57.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:122:0) after 1m0s
[11:07:57.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:122:0)
[11:07:57.518] Timer tick, asking Buildbucket for the build status
[11:07:57.807] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:57.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:123:0) after 1m0s
[11:08:57.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:123:0)
[11:08:57.836] Timer tick, asking Buildbucket for the build status
[11:08:58.279] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:58.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:124:0) after 1m0s
[11:09:58.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:124:0)
[11:09:58.352] Timer tick, asking Buildbucket for the build status
[11:09:58.745] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:58.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:125:0) after 1m0s
[11:10:58.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:125:0)
[11:10:58.793] Timer tick, asking Buildbucket for the build status
[11:10:58.951] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:58.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:126:0) after 1m0s
[11:11:58.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:126:0)
[11:11:58.987] Timer tick, asking Buildbucket for the build status
[11:11:59.476] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:59.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:127:0) after 1m0s
[11:12:59.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:127:0)
[11:12:59.497] Timer tick, asking Buildbucket for the build status
[11:12:59.649] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:59.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:128:0) after 1m0s
[11:13:59.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:128:0)
[11:13:59.679] Timer tick, asking Buildbucket for the build status
[11:13:59.994] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:59.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:129:0) after 1m0s
[11:15:00.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:129:0)
[11:15:00.099] Timer tick, asking Buildbucket for the build status
[11:15:00.293] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:00.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:130:0) after 1m0s
[11:16:00.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:130:0)
[11:16:00.341] Timer tick, asking Buildbucket for the build status
[11:16:00.475] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:00.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:131:0) after 1m0s
[11:17:00.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:131:0)
[11:17:00.507] Timer tick, asking Buildbucket for the build status
[11:17:00.857] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:00.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:132:0) after 1m0s
[11:18:01.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:132:0)
[11:18:01.045] Timer tick, asking Buildbucket for the build status
[11:18:01.240] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:01.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:133:0) after 1m0s
[11:19:01.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:133:0)
[11:19:01.272] Timer tick, asking Buildbucket for the build status
[11:19:01.402] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:01.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:134:0) after 1m0s
[11:20:01.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:134:0)
[11:20:01.421] Timer tick, asking Buildbucket for the build status
[11:20:01.521] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:01.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:135:0) after 1m0s
[11:21:01.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:135:0)
[11:21:01.590] Timer tick, asking Buildbucket for the build status
[11:21:01.768] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:01.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:136:0) after 1m0s
[11:22:01.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:136:0)
[11:22:01.906] Timer tick, asking Buildbucket for the build status
[11:22:02.039] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:02.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:137:0) after 1m0s
[11:23:02.269] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:137:0)
[11:23:02.269] Timer tick, asking Buildbucket for the build status
[11:23:02.435] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:02.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:138:0) after 1m0s
[11:24:02.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:138:0)
[11:24:02.464] Timer tick, asking Buildbucket for the build status
[11:24:02.692] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:02.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:139:0) after 1m0s
[11:25:02.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:139:0)
[11:25:02.746] Timer tick, asking Buildbucket for the build status
[11:25:02.882] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:02.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:140:0) after 1m0s
[11:26:03.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:140:0)
[11:26:03.052] Timer tick, asking Buildbucket for the build status
[11:26:03.394] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:03.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:141:0) after 1m0s
[11:27:03.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:141:0)
[11:27:03.603] Timer tick, asking Buildbucket for the build status
[11:27:03.786] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:03.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:142:0) after 1m0s
[11:28:03.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:142:0)
[11:28:03.909] Timer tick, asking Buildbucket for the build status
[11:28:04.056] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:04.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:143:0) after 1m0s
[11:29:04.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:143:0)
[11:29:04.807] Timer tick, asking Buildbucket for the build status
[11:29:05.003] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:05.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:144:0) after 1m0s
[11:30:05.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:144:0)
[11:30:05.213] Timer tick, asking Buildbucket for the build status
[11:30:05.328] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:05.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:145:0) after 1m0s
[11:31:12.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:145:0)
[11:31:12.374] Timer tick, asking Buildbucket for the build status
[11:31:12.810] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:12.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:146:0) after 1m0s
[11:32:12.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:146:0)
[11:32:12.882] Timer tick, asking Buildbucket for the build status
[11:32:13.058] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:13.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:147:0) after 1m0s
[11:33:13.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:147:0)
[11:33:13.092] Timer tick, asking Buildbucket for the build status
[11:33:13.277] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:13.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:148:0) after 1m0s
[11:34:13.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:148:0)
[11:34:13.306] Timer tick, asking Buildbucket for the build status
[11:34:13.602] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:13.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:149:0) after 1m0s
[11:35:13.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:149:0)
[11:35:13.692] Timer tick, asking Buildbucket for the build status
[11:35:14.122] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:14.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:150:0) after 1m0s
[11:36:14.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:150:0)
[11:36:14.161] Timer tick, asking Buildbucket for the build status
[11:36:14.639] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:14.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:151:0) after 1m0s
[11:37:14.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:151:0)
[11:37:14.670] Timer tick, asking Buildbucket for the build status
[11:37:14.936] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:14.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:152:0) after 1m0s
[11:38:14.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:152:0)
[11:38:14.961] Timer tick, asking Buildbucket for the build status
[11:38:15.294] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:15.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:153:0) after 1m0s
[11:39:15.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:153:0)
[11:39:15.271] Timer tick, asking Buildbucket for the build status
[11:39:15.644] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:15.644] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:154:0) after 1m0s
[11:40:15.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:154:0)
[11:40:15.889] Timer tick, asking Buildbucket for the build status
[11:40:16.001] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:16.001] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:155:0) after 1m0s
[11:41:16.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:155:0)
[11:41:16.096] Timer tick, asking Buildbucket for the build status
[11:41:16.537] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:16.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:156:0) after 1m0s
[11:42:16.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:156:0)
[11:42:16.748] Timer tick, asking Buildbucket for the build status
[11:42:16.949] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:16.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:157:0) after 1m0s
[11:43:17.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:157:0)
[11:43:17.279] Timer tick, asking Buildbucket for the build status
[11:43:17.445] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:17.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:158:0) after 1m0s
[11:44:23.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:158:0)
[11:44:23.154] Timer tick, asking Buildbucket for the build status
[11:44:23.282] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:23.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:159:0) after 1m0s
[11:45:23.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:159:0)
[11:45:23.336] Timer tick, asking Buildbucket for the build status
[11:45:23.471] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:23.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:160:0) after 1m0s
[11:46:23.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:160:0)
[11:46:23.544] Timer tick, asking Buildbucket for the build status
[11:46:24.357] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:24.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:161:0) after 1m0s
[11:47:24.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:161:0)
[11:47:24.386] Timer tick, asking Buildbucket for the build status
[11:47:24.840] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:24.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:162:0) after 1m0s
[11:48:24.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:162:0)
[11:48:24.876] Timer tick, asking Buildbucket for the build status
[11:48:25.188] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:25.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:163:0) after 1m0s
[11:49:25.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:163:0)
[11:49:25.253] Timer tick, asking Buildbucket for the build status
[11:49:25.566] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:25.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:164:0) after 1m0s
[11:50:25.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:164:0)
[11:50:25.606] Timer tick, asking Buildbucket for the build status
[11:50:25.873] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:25.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:165:0) after 1m0s
[11:51:25.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:165:0)
[11:51:25.941] Timer tick, asking Buildbucket for the build status
[11:51:26.553] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:26.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:166:0) after 1m0s
[11:52:26.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:166:0)
[11:52:26.660] Timer tick, asking Buildbucket for the build status
[11:52:27.038] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:27.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:167:0) after 1m0s
[11:53:27.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:167:0)
[11:53:27.144] Timer tick, asking Buildbucket for the build status
[11:53:27.267] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:27.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:168:0) after 1m0s
[11:54:27.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:168:0)
[11:54:27.334] Timer tick, asking Buildbucket for the build status
[11:54:27.639] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:27.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:169:0) after 1m0s
[11:55:27.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:169:0)
[11:55:27.707] Timer tick, asking Buildbucket for the build status
[11:55:27.904] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:27.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:170:0) after 1m0s
[11:56:27.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:170:0)
[11:56:27.970] Timer tick, asking Buildbucket for the build status
[11:56:28.059] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:28.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:171:0) after 1m0s
[11:57:28.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:171:0)
[11:57:28.157] Timer tick, asking Buildbucket for the build status
[11:57:28.283] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:28.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:172:0) after 1m0s
[11:58:28.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:172:0)
[11:58:28.373] Timer tick, asking Buildbucket for the build status
[11:58:28.742] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:28.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:173:0) after 1m0s
[11:59:28.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:173:0)
[11:59:28.853] Timer tick, asking Buildbucket for the build status
[11:59:29.022] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:29.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:174:0) after 1m0s
[12:00:29.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:174:0)
[12:00:29.147] Timer tick, asking Buildbucket for the build status
[12:00:29.534] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:29.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:175:0) after 1m0s
[12:01:29.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:175:0)
[12:01:29.528] Timer tick, asking Buildbucket for the build status
[12:01:29.647] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:29.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:176:0) after 1m0s
[12:02:29.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:176:0)
[12:02:29.679] Timer tick, asking Buildbucket for the build status
[12:02:30.376] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:30.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:177:0) after 1m0s
[12:03:30.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:177:0)
[12:03:30.417] Timer tick, asking Buildbucket for the build status
[12:03:30.539] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:30.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:178:0) after 1m0s
[12:04:30.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:178:0)
[12:04:30.656] Timer tick, asking Buildbucket for the build status
[12:04:31.049] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:31.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:179:0) after 1m0s
[12:05:31.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:179:0)
[12:05:31.144] Timer tick, asking Buildbucket for the build status
[12:05:31.299] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:31.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:180:0) after 1m0s
[12:06:31.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:180:0)
[12:06:31.324] Timer tick, asking Buildbucket for the build status
[12:06:31.524] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:31.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:181:0) after 1m0s
[12:07:31.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:181:0)
[12:07:31.569] Timer tick, asking Buildbucket for the build status
[12:07:31.687] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:31.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:182:0) after 1m0s
[12:08:31.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:182:0)
[12:08:31.717] Timer tick, asking Buildbucket for the build status
[12:08:31.889] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:31.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:183:0) after 1m0s
[12:09:31.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:183:0)
[12:09:31.915] Timer tick, asking Buildbucket for the build status
[12:09:32.069] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:32.069] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:184:0) after 1m0s
[12:10:32.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:184:0)
[12:10:32.068] Timer tick, asking Buildbucket for the build status
[12:10:32.194] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:32.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:185:0) after 1m0s
[12:11:32.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:185:0)
[12:11:32.259] Timer tick, asking Buildbucket for the build status
[12:11:32.594] Build 8883961373730948336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:32.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049391435825702048:186:0) after 1m0s
[12:12:31.041] Received PubSub notification, asking Buildbucket for the build status
[12:12:31.114] Build 8883961373730948336: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:12:31.114] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1586002349877407",
    "created_by": "project:infra",
    "created_ts": "1585991232135584",
    "id": "8883961373730948336",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4104.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"a12c8cc0-45ed-4710-8c8a-074530e9ffa3\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4104.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4104.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"a12c8cc0-45ed-4710-8c8a-074530e9ffa3\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-bai6\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"84.0.4104.0\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-bai6\"], \"image\": [\"chrome-xenial-20032900-6802ab9ce34\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4926-84b94b1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1585991855057203",
    "status": "COMPLETED",
    "status_changed_ts": "1586002350600152",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9049391435825702048",
      "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/8883961373730948336/+/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:4b5d433680f6a210",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1586002350642599",
    "url": "https://ci.chromium.org/b/8883961373730948336",
    "utcnow_ts": "1586002351106362"
  }
}
[12:12:31.114] Invocation finished in 3h5m20.36019883s with status SUCCEEDED