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

• parent_buildername:publish_tarball
• user_agent:recipe

[08:13:05.164] New invocation is queued and will start shortly
[08:13:05.164] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:13:06.641] Starting the invocation (attempt 1)
[08:13:06.699] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:13:06.699] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:13:06.699] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9043687230208885824",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4166.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"b156582e-9979-401d-ad78-400b7c6b305d\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4166.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:9043687230208885824",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[08:13:07.232] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1591431186832874",
    "id": "8878257167794741344",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4166.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"b156582e-9979-401d-ad78-400b7c6b305d\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4166.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1591431187067318",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9043687230208885824",
      "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/8878257167794741344/+/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": "1591431187067435",
    "url": "https://ci.chromium.org/b/8878257167794741344",
    "utcnow_ts": "1591431187223377"
  }
}
[08:13:07.232] Task URL: https://ci.chromium.org/b/8878257167794741344
[08:13:07.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:2:0) after 1m0s
[08:14:07.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:2:0)
[08:14:07.314] Timer tick, asking Buildbucket for the build status
[08:14:07.811] Build 8878257167794741344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:14:07.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:3:0) after 1m0s
[08:15:07.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:3:0)
[08:15:07.999] Timer tick, asking Buildbucket for the build status
[08:15:09.036] Build 8878257167794741344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:15:09.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:4:0) after 1m0s
[08:16:09.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:4:0)
[08:16:09.113] Timer tick, asking Buildbucket for the build status
[08:16:09.464] Build 8878257167794741344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:16:09.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:5:0) after 1m0s
[08:16:43.711] Received PubSub notification, asking Buildbucket for the build status
[08:16:44.011] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:09.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:5:0)
[08:17:09.580] Timer tick, asking Buildbucket for the build status
[08:17:10.412] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:10.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:7:0) after 1m0s
[08:18:10.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:7:0)
[08:18:10.447] Timer tick, asking Buildbucket for the build status
[08:18:10.651] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:10.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:8:0) after 1m0s
[08:19:10.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:8:0)
[08:19:10.708] Timer tick, asking Buildbucket for the build status
[08:19:11.331] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:11.331] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:9:0) after 1m0s
[08:20:11.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:9:0)
[08:20:11.439] Timer tick, asking Buildbucket for the build status
[08:20:11.738] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:11.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:10:0) after 1m0s
[08:21:11.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:10:0)
[08:21:11.759] Timer tick, asking Buildbucket for the build status
[08:21:12.822] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:12.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:11:0) after 1m0s
[08:22:12.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:11:0)
[08:22:12.892] Timer tick, asking Buildbucket for the build status
[08:22:13.036] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:13.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:12:0) after 1m0s
[08:23:13.072] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:12:0)
[08:23:13.072] Timer tick, asking Buildbucket for the build status
[08:23:13.222] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:13.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:13:0) after 1m0s
[08:24:13.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:13:0)
[08:24:13.389] Timer tick, asking Buildbucket for the build status
[08:24:13.566] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:13.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:14:0) after 1m0s
[08:25:13.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:14:0)
[08:25:13.629] Timer tick, asking Buildbucket for the build status
[08:25:13.947] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:13.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:15:0) after 1m0s
[08:26:14.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:15:0)
[08:26:14.138] Timer tick, asking Buildbucket for the build status
[08:26:14.439] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:14.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:16:0) after 1m0s
[08:27:14.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:16:0)
[08:27:14.602] Timer tick, asking Buildbucket for the build status
[08:27:14.785] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:14.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:17:0) after 1m0s
[08:28:14.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:17:0)
[08:28:14.886] Timer tick, asking Buildbucket for the build status
[08:28:15.127] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:15.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:18:0) after 1m0s
[08:29:15.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:18:0)
[08:29:15.166] Timer tick, asking Buildbucket for the build status
[08:29:15.931] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:15.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:19:0) after 1m0s
[08:30:15.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:19:0)
[08:30:15.954] Timer tick, asking Buildbucket for the build status
[08:30:16.185] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:16.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:20:0) after 1m0s
[08:31:16.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:20:0)
[08:31:16.314] Timer tick, asking Buildbucket for the build status
[08:31:17.882] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:17.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:21:0) after 1m0s
[08:32:18.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:21:0)
[08:32:18.034] Timer tick, asking Buildbucket for the build status
[08:32:18.483] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:18.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:22:0) after 1m0s
[08:33:18.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:22:0)
[08:33:18.646] Timer tick, asking Buildbucket for the build status
[08:33:18.847] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:18.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:23:0) after 1m0s
[08:34:18.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:23:0)
[08:34:18.889] Timer tick, asking Buildbucket for the build status
[08:34:19.087] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:19.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:24:0) after 1m0s
[08:35:19.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:24:0)
[08:35:19.105] Timer tick, asking Buildbucket for the build status
[08:35:19.572] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:19.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:25:0) after 1m0s
[08:36:19.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:25:0)
[08:36:19.674] Timer tick, asking Buildbucket for the build status
[08:36:19.917] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:19.917] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:26:0) after 1m0s
[08:37:19.990] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:26:0)
[08:37:19.990] Timer tick, asking Buildbucket for the build status
[08:37:20.186] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:20.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:27:0) after 1m0s
[08:38:20.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:27:0)
[08:38:20.484] Timer tick, asking Buildbucket for the build status
[08:38:20.719] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:20.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:28:0) after 1m0s
[08:39:20.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:28:0)
[08:39:20.750] Timer tick, asking Buildbucket for the build status
[08:39:21.131] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:21.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:29:0) after 1m0s
[08:40:21.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:29:0)
[08:40:21.275] Timer tick, asking Buildbucket for the build status
[08:40:21.564] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:21.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:30:0) after 1m0s
[08:41:21.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:30:0)
[08:41:21.673] Timer tick, asking Buildbucket for the build status
[08:41:23.192] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:23.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:31:0) after 1m0s
[08:42:23.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:31:0)
[08:42:23.252] Timer tick, asking Buildbucket for the build status
[08:42:23.845] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:23.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:32:0) after 1m0s
[08:43:23.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:32:0)
[08:43:23.985] Timer tick, asking Buildbucket for the build status
[08:43:24.542] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:24.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:33:0) after 1m0s
[08:44:24.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:33:0)
[08:44:24.570] Timer tick, asking Buildbucket for the build status
[08:44:24.777] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:24.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:34:0) after 1m0s
[08:45:24.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:34:0)
[08:45:24.813] Timer tick, asking Buildbucket for the build status
[08:45:25.211] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:25.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:35:0) after 1m0s
[08:46:25.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:35:0)
[08:46:25.309] Timer tick, asking Buildbucket for the build status
[08:46:26.201] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:26.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:36:0) after 1m0s
[08:47:26.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:36:0)
[08:47:26.303] Timer tick, asking Buildbucket for the build status
[08:47:27.506] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:27.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:37:0) after 1m0s
[08:48:27.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:37:0)
[08:48:27.574] Timer tick, asking Buildbucket for the build status
[08:48:27.790] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:27.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:38:0) after 1m0s
[08:49:27.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:38:0)
[08:49:27.829] Timer tick, asking Buildbucket for the build status
[08:49:28.191] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:28.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:39:0) after 1m0s
[08:50:28.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:39:0)
[08:50:28.311] Timer tick, asking Buildbucket for the build status
[08:50:28.936] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:28.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:40:0) after 1m0s
[08:51:29.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:40:0)
[08:51:29.021] Timer tick, asking Buildbucket for the build status
[08:51:29.610] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:29.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:41:0) after 1m0s
[08:52:30.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:41:0)
[08:52:30.213] Timer tick, asking Buildbucket for the build status
[08:52:30.487] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:30.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:42:0) after 1m0s
[08:53:30.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:42:0)
[08:53:30.607] Timer tick, asking Buildbucket for the build status
[08:53:30.780] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:30.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:43:0) after 1m0s
[08:54:30.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:43:0)
[08:54:30.825] Timer tick, asking Buildbucket for the build status
[08:54:30.999] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:31.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:44:0) after 1m0s
[08:55:31.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:44:0)
[08:55:31.078] Timer tick, asking Buildbucket for the build status
[08:55:31.216] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:31.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:45:0) after 1m0s
[08:56:31.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:45:0)
[08:56:31.241] Timer tick, asking Buildbucket for the build status
[08:56:31.733] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:31.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:46:0) after 1m0s
[08:57:31.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:46:0)
[08:57:31.823] Timer tick, asking Buildbucket for the build status
[08:57:32.186] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:32.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:47:0) after 1m0s
[08:58:32.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:47:0)
[08:58:32.283] Timer tick, asking Buildbucket for the build status
[08:58:32.904] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:32.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:48:0) after 1m0s
[08:59:32.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:48:0)
[08:59:32.929] Timer tick, asking Buildbucket for the build status
[08:59:33.107] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:33.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:49:0) after 1m0s
[09:00:33.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:49:0)
[09:00:33.235] Timer tick, asking Buildbucket for the build status
[09:00:33.759] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:33.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:50:0) after 1m0s
[09:01:33.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:50:0)
[09:01:33.902] Timer tick, asking Buildbucket for the build status
[09:01:34.364] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:34.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:51:0) after 1m0s
[09:02:34.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:51:0)
[09:02:34.459] Timer tick, asking Buildbucket for the build status
[09:02:34.739] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:34.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:52:0) after 1m0s
[09:03:34.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:52:0)
[09:03:34.846] Timer tick, asking Buildbucket for the build status
[09:03:35.322] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:35.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:53:0) after 1m0s
[09:04:35.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:53:0)
[09:04:35.320] Timer tick, asking Buildbucket for the build status
[09:04:35.939] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:35.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:54:0) after 1m0s
[09:05:36.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:54:0)
[09:05:36.035] Timer tick, asking Buildbucket for the build status
[09:05:36.850] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:36.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:55:0) after 1m0s
[09:06:36.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:55:0)
[09:06:36.883] Timer tick, asking Buildbucket for the build status
[09:06:37.010] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:37.010] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:56:0) after 1m0s
[09:07:37.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:56:0)
[09:07:37.111] Timer tick, asking Buildbucket for the build status
[09:07:37.446] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:37.446] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:57:0) after 1m0s
[09:08:37.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:57:0)
[09:08:37.463] Timer tick, asking Buildbucket for the build status
[09:08:38.431] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:38.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:58:0) after 1m0s
[09:09:38.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:58:0)
[09:09:38.532] Timer tick, asking Buildbucket for the build status
[09:09:38.659] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:38.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:59:0) after 1m0s
[09:10:38.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:59:0)
[09:10:38.811] Timer tick, asking Buildbucket for the build status
[09:10:39.097] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:39.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:60:0) after 1m0s
[09:11:39.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:60:0)
[09:11:39.435] Timer tick, asking Buildbucket for the build status
[09:11:39.636] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:39.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:61:0) after 1m0s
[09:12:39.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:61:0)
[09:12:39.775] Timer tick, asking Buildbucket for the build status
[09:12:40.579] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:40.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:62:0) after 1m0s
[09:13:40.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:62:0)
[09:13:40.710] Timer tick, asking Buildbucket for the build status
[09:13:41.426] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:41.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:63:0) after 1m0s
[09:14:41.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:63:0)
[09:14:41.497] Timer tick, asking Buildbucket for the build status
[09:14:41.716] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:41.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:64:0) after 1m0s
[09:15:41.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:64:0)
[09:15:41.727] Timer tick, asking Buildbucket for the build status
[09:15:44.469] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:44.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:65:0) after 1m0s
[09:16:44.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:65:0)
[09:16:44.551] Timer tick, asking Buildbucket for the build status
[09:16:44.731] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:44.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:66:0) after 1m0s
[09:17:44.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:66:0)
[09:17:44.864] Timer tick, asking Buildbucket for the build status
[09:17:45.597] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:45.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:67:0) after 1m0s
[09:18:45.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:67:0)
[09:18:45.593] Timer tick, asking Buildbucket for the build status
[09:18:46.323] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:46.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:68:0) after 1m0s
[09:19:46.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:68:0)
[09:19:46.347] Timer tick, asking Buildbucket for the build status
[09:19:46.510] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:46.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:69:0) after 1m0s
[09:20:46.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:69:0)
[09:20:46.549] Timer tick, asking Buildbucket for the build status
[09:20:46.729] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:46.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:70:0) after 1m0s
[09:21:46.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:70:0)
[09:21:46.741] Timer tick, asking Buildbucket for the build status
[09:21:46.949] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:46.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:71:0) after 1m0s
[09:22:47.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:71:0)
[09:22:47.045] Timer tick, asking Buildbucket for the build status
[09:22:47.521] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:47.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:72:0) after 1m0s
[09:23:47.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:72:0)
[09:23:47.555] Timer tick, asking Buildbucket for the build status
[09:23:47.878] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:47.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:73:0) after 1m0s
[09:24:47.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:73:0)
[09:24:47.927] Timer tick, asking Buildbucket for the build status
[09:24:48.449] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:48.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:74:0) after 1m0s
[09:25:48.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:74:0)
[09:25:48.485] Timer tick, asking Buildbucket for the build status
[09:25:49.242] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:49.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:75:0) after 1m0s
[09:26:49.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:75:0)
[09:26:49.274] Timer tick, asking Buildbucket for the build status
[09:26:49.413] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:49.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:76:0) after 1m0s
[09:27:49.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:76:0)
[09:27:49.496] Timer tick, asking Buildbucket for the build status
[09:27:49.712] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:49.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:77:0) after 1m0s
[09:28:49.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:77:0)
[09:28:49.768] Timer tick, asking Buildbucket for the build status
[09:28:50.111] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:50.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:78:0) after 1m0s
[09:29:50.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:78:0)
[09:29:50.186] Timer tick, asking Buildbucket for the build status
[09:29:50.784] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:50.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:79:0) after 1m0s
[09:30:50.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:79:0)
[09:30:50.841] Timer tick, asking Buildbucket for the build status
[09:30:51.397] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:51.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:80:0) after 1m0s
[09:31:51.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:80:0)
[09:31:51.468] Timer tick, asking Buildbucket for the build status
[09:31:51.668] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:51.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:81:0) after 1m0s
[09:32:51.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:81:0)
[09:32:51.714] Timer tick, asking Buildbucket for the build status
[09:32:51.877] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:51.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:82:0) after 1m0s
[09:33:52.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:82:0)
[09:33:52.001] Timer tick, asking Buildbucket for the build status
[09:33:52.357] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:52.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:83:0) after 1m0s
[09:34:52.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:83:0)
[09:34:52.435] Timer tick, asking Buildbucket for the build status
[09:34:52.836] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:52.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:84:0) after 1m0s
[09:35:52.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:84:0)
[09:35:52.864] Timer tick, asking Buildbucket for the build status
[09:35:53.123] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:53.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:85:0) after 1m0s
[09:36:53.180] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:85:0)
[09:36:53.180] Timer tick, asking Buildbucket for the build status
[09:36:53.349] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:53.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:86:0) after 1m0s
[09:37:53.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:86:0)
[09:37:53.521] Timer tick, asking Buildbucket for the build status
[09:37:53.690] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:53.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:87:0) after 1m0s
[09:38:53.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:87:0)
[09:38:53.702] Timer tick, asking Buildbucket for the build status
[09:38:54.349] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:54.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:88:0) after 1m0s
[09:39:54.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:88:0)
[09:39:54.439] Timer tick, asking Buildbucket for the build status
[09:39:54.691] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:54.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:89:0) after 1m0s
[09:40:55.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:89:0)
[09:40:55.049] Timer tick, asking Buildbucket for the build status
[09:40:55.515] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:55.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:90:0) after 1m0s
[09:41:55.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:90:0)
[09:41:55.819] Timer tick, asking Buildbucket for the build status
[09:41:56.199] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:56.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:91:0) after 1m0s
[09:42:56.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:91:0)
[09:42:56.517] Timer tick, asking Buildbucket for the build status
[09:42:56.796] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:56.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:92:0) after 1m0s
[09:43:56.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:92:0)
[09:43:56.866] Timer tick, asking Buildbucket for the build status
[09:43:57.012] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:57.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:93:0) after 1m0s
[09:44:57.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:93:0)
[09:44:57.172] Timer tick, asking Buildbucket for the build status
[09:44:57.457] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:57.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:94:0) after 1m0s
[09:45:57.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:94:0)
[09:45:57.492] Timer tick, asking Buildbucket for the build status
[09:45:57.760] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:57.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:95:0) after 1m0s
[09:46:57.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:95:0)
[09:46:57.868] Timer tick, asking Buildbucket for the build status
[09:46:58.198] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:58.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:96:0) after 1m0s
[09:47:58.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:96:0)
[09:47:58.219] Timer tick, asking Buildbucket for the build status
[09:47:58.866] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:58.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:97:0) after 1m0s
[09:48:58.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:97:0)
[09:48:58.984] Timer tick, asking Buildbucket for the build status
[09:48:59.169] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:59.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:98:0) after 1m0s
[09:49:59.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:98:0)
[09:49:59.167] Timer tick, asking Buildbucket for the build status
[09:49:59.632] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:59.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:99:0) after 1m0s
[09:50:59.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:99:0)
[09:50:59.704] Timer tick, asking Buildbucket for the build status
[09:51:00.236] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:00.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:100:0) after 1m0s
[09:52:00.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:100:0)
[09:52:00.271] Timer tick, asking Buildbucket for the build status
[09:52:00.637] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:00.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:101:0) after 1m0s
[09:53:00.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:101:0)
[09:53:00.881] Timer tick, asking Buildbucket for the build status
[09:53:01.108] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:01.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:102:0) after 1m0s
[09:54:01.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:102:0)
[09:54:01.484] Timer tick, asking Buildbucket for the build status
[09:54:01.825] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:01.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:103:0) after 1m0s
[09:55:01.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:103:0)
[09:55:01.892] Timer tick, asking Buildbucket for the build status
[09:55:02.265] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:02.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:104:0) after 1m0s
[09:56:02.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:104:0)
[09:56:02.289] Timer tick, asking Buildbucket for the build status
[09:56:04.267] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:04.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:105:0) after 1m0s
[09:57:04.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:105:0)
[09:57:04.351] Timer tick, asking Buildbucket for the build status
[09:57:04.547] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:04.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:106:0) after 1m0s
[09:58:04.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:106:0)
[09:58:04.645] Timer tick, asking Buildbucket for the build status
[09:58:04.959] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:04.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:107:0) after 1m0s
[09:59:05.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:107:0)
[09:59:05.058] Timer tick, asking Buildbucket for the build status
[09:59:06.253] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:06.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:108:0) after 1m0s
[10:00:06.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:108:0)
[10:00:06.358] Timer tick, asking Buildbucket for the build status
[10:00:07.553] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:07.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:109:0) after 1m0s
[10:01:08.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:109:0)
[10:01:08.127] Timer tick, asking Buildbucket for the build status
[10:01:08.840] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:08.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:110:0) after 1m0s
[10:02:09.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:110:0)
[10:02:09.028] Timer tick, asking Buildbucket for the build status
[10:02:09.715] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:09.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:111:0) after 1m0s
[10:03:09.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:111:0)
[10:03:09.754] Timer tick, asking Buildbucket for the build status
[10:03:10.162] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:10.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:112:0) after 1m0s
[10:04:10.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:112:0)
[10:04:10.259] Timer tick, asking Buildbucket for the build status
[10:04:10.578] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:10.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:113:0) after 1m0s
[10:05:10.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:113:0)
[10:05:10.733] Timer tick, asking Buildbucket for the build status
[10:05:10.903] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:10.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:114:0) after 1m0s
[10:06:11.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:114:0)
[10:06:11.053] Timer tick, asking Buildbucket for the build status
[10:06:12.106] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:12.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:115:0) after 1m0s
[10:07:12.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:115:0)
[10:07:12.145] Timer tick, asking Buildbucket for the build status
[10:07:14.003] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:14.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:116:0) after 1m0s
[10:08:14.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:116:0)
[10:08:14.054] Timer tick, asking Buildbucket for the build status
[10:08:14.188] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:14.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:117:0) after 1m0s
[10:09:14.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:117:0)
[10:09:14.353] Timer tick, asking Buildbucket for the build status
[10:09:14.456] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:14.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:118:0) after 1m0s
[10:10:14.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:118:0)
[10:10:14.500] Timer tick, asking Buildbucket for the build status
[10:10:14.680] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:14.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:119:0) after 1m0s
[10:11:14.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:119:0)
[10:11:14.713] Timer tick, asking Buildbucket for the build status
[10:11:15.269] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:15.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:120:0) after 1m0s
[10:12:15.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:120:0)
[10:12:15.354] Timer tick, asking Buildbucket for the build status
[10:12:16.075] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:16.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:121:0) after 1m0s
[10:13:16.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:121:0)
[10:13:16.149] Timer tick, asking Buildbucket for the build status
[10:13:16.343] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:16.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:122:0) after 1m0s
[10:14:16.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:122:0)
[10:14:16.384] Timer tick, asking Buildbucket for the build status
[10:14:16.770] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:16.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:123:0) after 1m0s
[10:15:16.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:123:0)
[10:15:16.838] Timer tick, asking Buildbucket for the build status
[10:15:17.157] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:17.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:124:0) after 1m0s
[10:16:17.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:124:0)
[10:16:17.256] Timer tick, asking Buildbucket for the build status
[10:16:17.415] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:17.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:125:0) after 1m0s
[10:17:17.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:125:0)
[10:17:17.437] Timer tick, asking Buildbucket for the build status
[10:17:17.839] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:17.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:126:0) after 1m0s
[10:18:17.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:126:0)
[10:18:17.873] Timer tick, asking Buildbucket for the build status
[10:18:18.328] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:18.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:127:0) after 1m0s
[10:19:18.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:127:0)
[10:19:18.366] Timer tick, asking Buildbucket for the build status
[10:19:18.513] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:18.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:128:0) after 1m0s
[10:20:18.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:128:0)
[10:20:18.575] Timer tick, asking Buildbucket for the build status
[10:20:19.136] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:19.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:129:0) after 1m0s
[10:21:19.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:129:0)
[10:21:19.213] Timer tick, asking Buildbucket for the build status
[10:21:19.490] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:19.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:130:0) after 1m0s
[10:22:19.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:130:0)
[10:22:19.542] Timer tick, asking Buildbucket for the build status
[10:22:19.872] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:19.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:131:0) after 1m0s
[10:23:19.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:131:0)
[10:23:19.896] Timer tick, asking Buildbucket for the build status
[10:23:20.822] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:20.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:132:0) after 1m0s
[10:24:20.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:132:0)
[10:24:20.924] Timer tick, asking Buildbucket for the build status
[10:24:22.321] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:22.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:133:0) after 1m0s
[10:25:22.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:133:0)
[10:25:22.384] Timer tick, asking Buildbucket for the build status
[10:25:24.142] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:24.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:134:0) after 1m0s
[10:26:24.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:134:0)
[10:26:24.166] Timer tick, asking Buildbucket for the build status
[10:26:24.495] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:24.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:135:0) after 1m0s
[10:27:24.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:135:0)
[10:27:24.520] Timer tick, asking Buildbucket for the build status
[10:27:25.078] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:25.078] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:136:0) after 1m0s
[10:28:25.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:136:0)
[10:28:25.147] Timer tick, asking Buildbucket for the build status
[10:28:25.545] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:25.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:137:0) after 1m0s
[10:29:25.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:137:0)
[10:29:25.680] Timer tick, asking Buildbucket for the build status
[10:29:25.864] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:25.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:138:0) after 1m0s
[10:30:25.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:138:0)
[10:30:25.968] Timer tick, asking Buildbucket for the build status
[10:30:27.453] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:27.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:139:0) after 1m0s
[10:31:27.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:139:0)
[10:31:27.586] Timer tick, asking Buildbucket for the build status
[10:31:27.814] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:27.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:140:0) after 1m0s
[10:32:27.926] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:140:0)
[10:32:27.926] Timer tick, asking Buildbucket for the build status
[10:32:29.068] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:29.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:141:0) after 1m0s
[10:33:29.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:141:0)
[10:33:29.145] Timer tick, asking Buildbucket for the build status
[10:33:29.605] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:29.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:142:0) after 1m0s
[10:34:29.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:142:0)
[10:34:29.725] Timer tick, asking Buildbucket for the build status
[10:34:30.363] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:30.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:143:0) after 1m0s
[10:35:30.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:143:0)
[10:35:30.435] Timer tick, asking Buildbucket for the build status
[10:35:30.831] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:30.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:144:0) after 1m0s
[10:36:30.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:144:0)
[10:36:30.868] Timer tick, asking Buildbucket for the build status
[10:36:31.227] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:31.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:145:0) after 1m0s
[10:37:31.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:145:0)
[10:37:31.301] Timer tick, asking Buildbucket for the build status
[10:37:32.802] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:32.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:146:0) after 1m0s
[10:38:32.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:146:0)
[10:38:32.843] Timer tick, asking Buildbucket for the build status
[10:38:33.059] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:33.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:147:0) after 1m0s
[10:39:33.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:147:0)
[10:39:33.091] Timer tick, asking Buildbucket for the build status
[10:39:33.228] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:33.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:148:0) after 1m0s
[10:40:33.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:148:0)
[10:40:33.283] Timer tick, asking Buildbucket for the build status
[10:40:33.556] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:33.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:149:0) after 1m0s
[10:41:33.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:149:0)
[10:41:33.564] Timer tick, asking Buildbucket for the build status
[10:41:33.818] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:33.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:150:0) after 1m0s
[10:42:33.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:150:0)
[10:42:33.857] Timer tick, asking Buildbucket for the build status
[10:42:34.783] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:34.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:151:0) after 1m0s
[10:43:34.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:151:0)
[10:43:34.972] Timer tick, asking Buildbucket for the build status
[10:43:35.173] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:35.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:152:0) after 1m0s
[10:44:35.280] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:152:0)
[10:44:35.280] Timer tick, asking Buildbucket for the build status
[10:44:35.516] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:35.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:153:0) after 1m0s
[10:45:35.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:153:0)
[10:45:35.576] Timer tick, asking Buildbucket for the build status
[10:45:40.809] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:40.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:154:0) after 1m0s
[10:46:40.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:154:0)
[10:46:40.974] Timer tick, asking Buildbucket for the build status
[10:46:41.336] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:41.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:155:0) after 1m0s
[10:47:41.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:155:0)
[10:47:41.368] Timer tick, asking Buildbucket for the build status
[10:47:41.646] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:41.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:156:0) after 1m0s
[10:48:41.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:156:0)
[10:48:41.682] Timer tick, asking Buildbucket for the build status
[10:48:42.067] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:42.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:157:0) after 1m0s
[10:49:42.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:157:0)
[10:49:42.145] Timer tick, asking Buildbucket for the build status
[10:49:42.332] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:42.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:158:0) after 1m0s
[10:50:42.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:158:0)
[10:50:42.471] Timer tick, asking Buildbucket for the build status
[10:50:42.672] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:42.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:159:0) after 1m0s
[10:51:42.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:159:0)
[10:51:42.726] Timer tick, asking Buildbucket for the build status
[10:51:43.297] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:43.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:160:0) after 1m0s
[10:52:43.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:160:0)
[10:52:43.507] Timer tick, asking Buildbucket for the build status
[10:52:43.734] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:43.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:161:0) after 1m0s
[10:53:43.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:161:0)
[10:53:43.804] Timer tick, asking Buildbucket for the build status
[10:53:44.065] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:44.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:162:0) after 1m0s
[10:54:44.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:162:0)
[10:54:44.092] Timer tick, asking Buildbucket for the build status
[10:54:44.219] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:44.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:163:0) after 1m0s
[10:55:44.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:163:0)
[10:55:44.245] Timer tick, asking Buildbucket for the build status
[10:55:45.022] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:45.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:164:0) after 1m0s
[10:56:45.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:164:0)
[10:56:45.177] Timer tick, asking Buildbucket for the build status
[10:56:45.461] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:45.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:165:0) after 1m0s
[10:57:45.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:165:0)
[10:57:45.554] Timer tick, asking Buildbucket for the build status
[10:57:45.736] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:45.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:166:0) after 1m0s
[10:58:45.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:166:0)
[10:58:45.811] Timer tick, asking Buildbucket for the build status
[10:58:45.967] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:45.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:167:0) after 1m0s
[10:59:46.222] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:167:0)
[10:59:46.222] Timer tick, asking Buildbucket for the build status
[10:59:46.479] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:46.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:168:0) after 1m0s
[11:00:46.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:168:0)
[11:00:46.544] Timer tick, asking Buildbucket for the build status
[11:00:46.882] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:46.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:169:0) after 1m0s
[11:01:46.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:169:0)
[11:01:46.996] Timer tick, asking Buildbucket for the build status
[11:01:48.791] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:48.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:170:0) after 1m0s
[11:02:48.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:170:0)
[11:02:48.896] Timer tick, asking Buildbucket for the build status
[11:02:49.476] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:49.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:171:0) after 1m0s
[11:03:49.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:171:0)
[11:03:49.492] Timer tick, asking Buildbucket for the build status
[11:03:50.242] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:50.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:172:0) after 1m0s
[11:04:50.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:172:0)
[11:04:50.287] Timer tick, asking Buildbucket for the build status
[11:04:50.758] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:50.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:173:0) after 1m0s
[11:05:50.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:173:0)
[11:05:50.852] Timer tick, asking Buildbucket for the build status
[11:05:51.004] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:51.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:174:0) after 1m0s
[11:06:51.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:174:0)
[11:06:51.042] Timer tick, asking Buildbucket for the build status
[11:06:51.292] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:51.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:175:0) after 1m0s
[11:07:51.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:175:0)
[11:07:51.335] Timer tick, asking Buildbucket for the build status
[11:07:51.462] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:51.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:176:0) after 1m0s
[11:08:51.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:176:0)
[11:08:51.678] Timer tick, asking Buildbucket for the build status
[11:08:51.817] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:51.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:177:0) after 1m0s
[11:09:52.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:177:0)
[11:09:52.085] Timer tick, asking Buildbucket for the build status
[11:09:52.266] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:52.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:178:0) after 1m0s
[11:10:52.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:178:0)
[11:10:52.462] Timer tick, asking Buildbucket for the build status
[11:10:52.816] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:52.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:179:0) after 1m0s
[11:11:53.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:179:0)
[11:11:53.192] Timer tick, asking Buildbucket for the build status
[11:11:53.477] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:53.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:180:0) after 1m0s
[11:12:53.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:180:0)
[11:12:53.575] Timer tick, asking Buildbucket for the build status
[11:12:54.824] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:54.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:181:0) after 1m0s
[11:13:54.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:181:0)
[11:13:54.913] Timer tick, asking Buildbucket for the build status
[11:13:55.236] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:55.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:182:0) after 1m0s
[11:14:55.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:182:0)
[11:14:55.505] Timer tick, asking Buildbucket for the build status
[11:14:55.737] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:55.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:183:0) after 1m0s
[11:15:55.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:183:0)
[11:15:55.899] Timer tick, asking Buildbucket for the build status
[11:15:56.275] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:56.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:184:0) after 1m0s
[11:16:56.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:184:0)
[11:16:56.354] Timer tick, asking Buildbucket for the build status
[11:16:56.886] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:56.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:185:0) after 1m0s
[11:17:57.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:185:0)
[11:17:57.092] Timer tick, asking Buildbucket for the build status
[11:17:57.262] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:57.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:186:0) after 1m0s
[11:18:57.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:186:0)
[11:18:57.292] Timer tick, asking Buildbucket for the build status
[11:18:57.491] Build 8878257167794741344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:57.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043687230208885824:187:0) after 1m0s
[11:19:27.228] Received PubSub notification, asking Buildbucket for the build status
[11:19:27.370] Build 8878257167794741344: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:19:27.370] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1591442365675211",
    "created_by": "project:infra",
    "created_ts": "1591431186832874",
    "id": "8878257167794741344",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4166.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"b156582e-9979-401d-ad78-400b7c6b305d\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4166.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"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-dd41\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"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\": [\"5168-d212e19\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1591431402374646",
    "status": "COMPLETED",
    "status_changed_ts": "1591442366333198",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9043687230208885824",
      "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/8878257167794741344/+/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:4ca1825b7d3db310",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1591442366371343",
    "url": "https://ci.chromium.org/b/8878257167794741344",
    "utcnow_ts": "1591442367354122"
  }
}
[11:19:27.370] Invocation finished in 3h6m22.224053203s with status SUCCEEDED