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

• parent_buildername:publish_tarball
• user_agent:recipe

[06:59:58.090] New invocation is queued and will start shortly
[06:59:58.090] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[06:59:59.213] Starting the invocation (attempt 1)
[06:59:59.248] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:59:59.248] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:59:59.248] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9043963621286839344",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"83.0.4103.96\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"e18ddf56-e0ce-471c-ab4a-5b5a1e1e0b68\",\"title\":\"publish_tarball/0\"}]},\"version\":\"83.0.4103.96\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9043963621286839344",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[07:00:00.118] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1591167599385555",
    "id": "8878533559265532704",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4103.96\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e18ddf56-e0ce-471c-ab4a-5b5a1e1e0b68\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4103.96\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1591167599804794",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9043963621286839344",
      "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/8878533559265532704/+/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": "1591167599804967",
    "url": "https://ci.chromium.org/b/8878533559265532704",
    "utcnow_ts": "1591167600106877"
  }
}
[07:00:00.118] Task URL: https://ci.chromium.org/b/8878533559265532704
[07:00:00.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:2:0) after 1m0s
[07:00:03.024] Received PubSub notification, asking Buildbucket for the build status
[07:00:03.128] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:00.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:2:0)
[07:01:00.154] Timer tick, asking Buildbucket for the build status
[07:01:00.661] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:00.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:4:0) after 1m0s
[07:02:00.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:4:0)
[07:02:00.983] Timer tick, asking Buildbucket for the build status
[07:02:01.372] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:01.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:5:0) after 1m0s
[07:03:01.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:5:0)
[07:03:01.404] Timer tick, asking Buildbucket for the build status
[07:03:01.529] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:01.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:6:0) after 1m0s
[07:04:03.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:6:0)
[07:04:03.995] Timer tick, asking Buildbucket for the build status
[07:04:04.373] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:04.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:7:0) after 1m0s
[07:05:04.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:7:0)
[07:05:04.402] Timer tick, asking Buildbucket for the build status
[07:05:04.587] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:04.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:8:0) after 1m0s
[07:06:04.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:8:0)
[07:06:04.596] Timer tick, asking Buildbucket for the build status
[07:06:04.752] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:04.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:9:0) after 1m0s
[07:07:04.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:9:0)
[07:07:04.770] Timer tick, asking Buildbucket for the build status
[07:07:04.909] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:04.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:10:0) after 1m0s
[07:08:04.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:10:0)
[07:08:04.975] Timer tick, asking Buildbucket for the build status
[07:08:06.209] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:06.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:11:0) after 1m0s
[07:09:06.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:11:0)
[07:09:06.471] Timer tick, asking Buildbucket for the build status
[07:09:06.619] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:06.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:12:0) after 1m0s
[07:10:06.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:12:0)
[07:10:06.662] Timer tick, asking Buildbucket for the build status
[07:10:08.308] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:08.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:13:0) after 1m0s
[07:11:08.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:13:0)
[07:11:08.382] Timer tick, asking Buildbucket for the build status
[07:11:08.537] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:08.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:14:0) after 1m0s
[07:12:08.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:14:0)
[07:12:08.657] Timer tick, asking Buildbucket for the build status
[07:12:09.014] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:09.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:15:0) after 1m0s
[07:13:09.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:15:0)
[07:13:09.052] Timer tick, asking Buildbucket for the build status
[07:13:09.316] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:09.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:16:0) after 1m0s
[07:14:09.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:16:0)
[07:14:09.452] Timer tick, asking Buildbucket for the build status
[07:14:11.079] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:11.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:17:0) after 1m0s
[07:15:11.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:17:0)
[07:15:11.139] Timer tick, asking Buildbucket for the build status
[07:15:11.385] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:11.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:18:0) after 1m0s
[07:16:11.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:18:0)
[07:16:11.584] Timer tick, asking Buildbucket for the build status
[07:16:12.754] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:12.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:19:0) after 1m0s
[07:17:12.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:19:0)
[07:17:12.769] Timer tick, asking Buildbucket for the build status
[07:17:12.991] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:12.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:20:0) after 1m0s
[07:18:13.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:20:0)
[07:18:13.122] Timer tick, asking Buildbucket for the build status
[07:18:13.507] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:13.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:21:0) after 1m0s
[07:19:13.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:21:0)
[07:19:13.653] Timer tick, asking Buildbucket for the build status
[07:19:13.792] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:13.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:22:0) after 1m0s
[07:20:14.072] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:22:0)
[07:20:14.072] Timer tick, asking Buildbucket for the build status
[07:20:14.707] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:14.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:23:0) after 1m0s
[07:21:14.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:23:0)
[07:21:14.764] Timer tick, asking Buildbucket for the build status
[07:21:15.438] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:15.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:24:0) after 1m0s
[07:22:15.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:24:0)
[07:22:15.436] Timer tick, asking Buildbucket for the build status
[07:22:15.742] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:15.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:25:0) after 1m0s
[07:23:15.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:25:0)
[07:23:15.767] Timer tick, asking Buildbucket for the build status
[07:23:16.136] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:16.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:26:0) after 1m0s
[07:24:16.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:26:0)
[07:24:16.259] Timer tick, asking Buildbucket for the build status
[07:24:16.511] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:16.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:27:0) after 1m0s
[07:25:16.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:27:0)
[07:25:16.549] Timer tick, asking Buildbucket for the build status
[07:25:17.095] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:17.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:28:0) after 1m0s
[07:26:17.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:28:0)
[07:26:17.185] Timer tick, asking Buildbucket for the build status
[07:26:17.568] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:17.568] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:29:0) after 1m0s
[07:27:17.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:29:0)
[07:27:17.607] Timer tick, asking Buildbucket for the build status
[07:27:17.838] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:17.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:30:0) after 1m0s
[07:28:17.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:30:0)
[07:28:17.930] Timer tick, asking Buildbucket for the build status
[07:28:18.152] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:18.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:31:0) after 1m0s
[07:29:18.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:31:0)
[07:29:18.199] Timer tick, asking Buildbucket for the build status
[07:29:18.569] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:18.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:32:0) after 1m0s
[07:30:18.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:32:0)
[07:30:18.612] Timer tick, asking Buildbucket for the build status
[07:30:18.885] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:18.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:33:0) after 1m0s
[07:31:18.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:33:0)
[07:31:18.970] Timer tick, asking Buildbucket for the build status
[07:31:19.190] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:19.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:34:0) after 1m0s
[07:32:19.222] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:34:0)
[07:32:19.222] Timer tick, asking Buildbucket for the build status
[07:32:19.472] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:19.473] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:35:0) after 1m0s
[07:33:19.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:35:0)
[07:33:19.556] Timer tick, asking Buildbucket for the build status
[07:33:21.274] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:21.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:36:0) after 1m0s
[07:34:21.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:36:0)
[07:34:21.404] Timer tick, asking Buildbucket for the build status
[07:34:22.324] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:22.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:37:0) after 1m0s
[07:35:22.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:37:0)
[07:35:22.377] Timer tick, asking Buildbucket for the build status
[07:35:22.870] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:22.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:38:0) after 1m0s
[07:36:22.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:38:0)
[07:36:22.985] Timer tick, asking Buildbucket for the build status
[07:36:23.122] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:23.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:39:0) after 1m0s
[07:37:23.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:39:0)
[07:37:23.216] Timer tick, asking Buildbucket for the build status
[07:37:23.452] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:23.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:40:0) after 1m0s
[07:38:23.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:40:0)
[07:38:23.484] Timer tick, asking Buildbucket for the build status
[07:38:23.636] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:23.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:41:0) after 1m0s
[07:39:23.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:41:0)
[07:39:23.690] Timer tick, asking Buildbucket for the build status
[07:39:24.094] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:24.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:42:0) after 1m0s
[07:40:24.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:42:0)
[07:40:24.301] Timer tick, asking Buildbucket for the build status
[07:40:25.368] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:25.368] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:43:0) after 1m0s
[07:41:25.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:43:0)
[07:41:25.487] Timer tick, asking Buildbucket for the build status
[07:41:25.847] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:25.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:44:0) after 1m0s
[07:42:25.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:44:0)
[07:42:25.883] Timer tick, asking Buildbucket for the build status
[07:42:27.483] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:27.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:45:0) after 1m0s
[07:43:27.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:45:0)
[07:43:27.575] Timer tick, asking Buildbucket for the build status
[07:43:27.695] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:27.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:46:0) after 1m0s
[07:44:28.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:46:0)
[07:44:28.108] Timer tick, asking Buildbucket for the build status
[07:44:28.262] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:28.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:47:0) after 1m0s
[07:45:28.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:47:0)
[07:45:28.397] Timer tick, asking Buildbucket for the build status
[07:45:28.558] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:28.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:48:0) after 1m0s
[07:46:28.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:48:0)
[07:46:28.733] Timer tick, asking Buildbucket for the build status
[07:46:29.077] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:29.077] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:49:0) after 1m0s
[07:47:29.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:49:0)
[07:47:29.223] Timer tick, asking Buildbucket for the build status
[07:47:29.366] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:29.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:50:0) after 1m0s
[07:48:29.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:50:0)
[07:48:29.516] Timer tick, asking Buildbucket for the build status
[07:48:29.730] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:29.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:51:0) after 1m0s
[07:49:30.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:51:0)
[07:49:30.066] Timer tick, asking Buildbucket for the build status
[07:49:30.196] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:30.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:52:0) after 1m0s
[07:50:30.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:52:0)
[07:50:30.240] Timer tick, asking Buildbucket for the build status
[07:50:30.371] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:30.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:53:0) after 1m0s
[07:51:30.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:53:0)
[07:51:30.679] Timer tick, asking Buildbucket for the build status
[07:51:31.137] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:31.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:54:0) after 1m0s
[07:52:31.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:54:0)
[07:52:31.321] Timer tick, asking Buildbucket for the build status
[07:52:31.630] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:31.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:55:0) after 1m0s
[07:53:31.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:55:0)
[07:53:31.668] Timer tick, asking Buildbucket for the build status
[07:53:34.454] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:34.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:56:0) after 1m0s
[07:54:34.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:56:0)
[07:54:34.595] Timer tick, asking Buildbucket for the build status
[07:54:34.941] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:34.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:57:0) after 1m0s
[07:55:35.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:57:0)
[07:55:35.027] Timer tick, asking Buildbucket for the build status
[07:55:35.254] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:35.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:58:0) after 1m0s
[07:56:35.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:58:0)
[07:56:35.276] Timer tick, asking Buildbucket for the build status
[07:56:35.566] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:35.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:59:0) after 1m0s
[07:57:35.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:59:0)
[07:57:35.592] Timer tick, asking Buildbucket for the build status
[07:57:37.373] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:37.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:60:0) after 1m0s
[07:58:37.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:60:0)
[07:58:37.400] Timer tick, asking Buildbucket for the build status
[07:58:37.623] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:37.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:61:0) after 1m0s
[07:59:37.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:61:0)
[07:59:37.690] Timer tick, asking Buildbucket for the build status
[07:59:37.881] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:37.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:62:0) after 1m0s
[08:00:37.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:62:0)
[08:00:37.940] Timer tick, asking Buildbucket for the build status
[08:00:38.509] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:38.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:63:0) after 1m0s
[08:01:38.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:63:0)
[08:01:38.539] Timer tick, asking Buildbucket for the build status
[08:01:39.385] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:39.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:64:0) after 1m0s
[08:02:39.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:64:0)
[08:02:39.416] Timer tick, asking Buildbucket for the build status
[08:02:39.603] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:39.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:65:0) after 1m0s
[08:03:39.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:65:0)
[08:03:39.759] Timer tick, asking Buildbucket for the build status
[08:03:39.929] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:39.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:66:0) after 1m0s
[08:04:40.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:66:0)
[08:04:40.009] Timer tick, asking Buildbucket for the build status
[08:04:40.301] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:40.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:67:0) after 1m0s
[08:05:40.326] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:67:0)
[08:05:40.326] Timer tick, asking Buildbucket for the build status
[08:05:40.436] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:40.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:68:0) after 1m0s
[08:06:40.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:68:0)
[08:06:40.503] Timer tick, asking Buildbucket for the build status
[08:06:40.725] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:40.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:69:0) after 1m0s
[08:07:40.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:69:0)
[08:07:40.750] Timer tick, asking Buildbucket for the build status
[08:07:41.083] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:41.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:70:0) after 1m0s
[08:08:41.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:70:0)
[08:08:41.172] Timer tick, asking Buildbucket for the build status
[08:08:44.703] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:44.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:71:0) after 1m0s
[08:09:44.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:71:0)
[08:09:44.794] Timer tick, asking Buildbucket for the build status
[08:09:44.921] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:44.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:72:0) after 1m0s
[08:10:44.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:72:0)
[08:10:44.970] Timer tick, asking Buildbucket for the build status
[08:10:45.151] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:45.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:73:0) after 1m0s
[08:11:45.180] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:73:0)
[08:11:45.180] Timer tick, asking Buildbucket for the build status
[08:11:45.371] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:45.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:74:0) after 1m0s
[08:12:45.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:74:0)
[08:12:45.395] Timer tick, asking Buildbucket for the build status
[08:12:45.604] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:45.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:75:0) after 1m0s
[08:13:45.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:75:0)
[08:13:45.749] Timer tick, asking Buildbucket for the build status
[08:13:45.923] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:45.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:76:0) after 1m0s
[08:14:45.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:76:0)
[08:14:45.946] Timer tick, asking Buildbucket for the build status
[08:14:46.104] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:46.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:77:0) after 1m0s
[08:15:46.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:77:0)
[08:15:46.089] Timer tick, asking Buildbucket for the build status
[08:15:46.447] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:46.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:78:0) after 1m0s
[08:16:46.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:78:0)
[08:16:46.521] Timer tick, asking Buildbucket for the build status
[08:16:46.960] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:46.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:79:0) after 1m0s
[08:17:47.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:79:0)
[08:17:47.068] Timer tick, asking Buildbucket for the build status
[08:17:47.249] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:47.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:80:0) after 1m0s
[08:18:47.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:80:0)
[08:18:47.285] Timer tick, asking Buildbucket for the build status
[08:18:47.498] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:47.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:81:0) after 1m0s
[08:19:47.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:81:0)
[08:19:47.507] Timer tick, asking Buildbucket for the build status
[08:19:47.686] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:47.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:82:0) after 1m0s
[08:20:47.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:82:0)
[08:20:47.738] Timer tick, asking Buildbucket for the build status
[08:20:47.916] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:47.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:83:0) after 1m0s
[08:21:47.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:83:0)
[08:21:47.966] Timer tick, asking Buildbucket for the build status
[08:21:48.342] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:48.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:84:0) after 1m0s
[08:22:48.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:84:0)
[08:22:48.368] Timer tick, asking Buildbucket for the build status
[08:22:48.825] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:48.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:85:0) after 1m0s
[08:23:48.844] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:85:0)
[08:23:48.844] Timer tick, asking Buildbucket for the build status
[08:23:49.158] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:49.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:86:0) after 1m0s
[08:24:49.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:86:0)
[08:24:49.245] Timer tick, asking Buildbucket for the build status
[08:24:49.390] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:49.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:87:0) after 1m0s
[08:25:49.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:87:0)
[08:25:49.384] Timer tick, asking Buildbucket for the build status
[08:25:49.514] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:49.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:88:0) after 1m0s
[08:26:49.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:88:0)
[08:26:49.545] Timer tick, asking Buildbucket for the build status
[08:26:49.703] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:49.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:89:0) after 1m0s
[08:27:49.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:89:0)
[08:27:49.758] Timer tick, asking Buildbucket for the build status
[08:27:49.995] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:49.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:90:0) after 1m0s
[08:28:50.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:90:0)
[08:28:50.020] Timer tick, asking Buildbucket for the build status
[08:28:50.536] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:50.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:91:0) after 1m0s
[08:29:50.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:91:0)
[08:29:50.626] Timer tick, asking Buildbucket for the build status
[08:29:50.991] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:50.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:92:0) after 1m0s
[08:30:51.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:92:0)
[08:30:51.049] Timer tick, asking Buildbucket for the build status
[08:30:53.795] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:53.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:93:0) after 1m0s
[08:31:53.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:93:0)
[08:31:53.824] Timer tick, asking Buildbucket for the build status
[08:31:53.942] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:53.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:94:0) after 1m0s
[08:32:53.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:94:0)
[08:32:53.994] Timer tick, asking Buildbucket for the build status
[08:32:54.314] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:54.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:95:0) after 1m0s
[08:33:54.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:95:0)
[08:33:54.362] Timer tick, asking Buildbucket for the build status
[08:33:54.525] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:54.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:96:0) after 1m0s
[08:34:54.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:96:0)
[08:34:54.552] Timer tick, asking Buildbucket for the build status
[08:34:55.032] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:55.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:97:0) after 1m0s
[08:35:55.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:97:0)
[08:35:55.114] Timer tick, asking Buildbucket for the build status
[08:35:55.481] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:55.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:98:0) after 1m0s
[08:36:55.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:98:0)
[08:36:55.605] Timer tick, asking Buildbucket for the build status
[08:36:55.796] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:55.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:99:0) after 1m0s
[08:37:55.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:99:0)
[08:37:55.823] Timer tick, asking Buildbucket for the build status
[08:37:56.192] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:56.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:100:0) after 1m0s
[08:38:56.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:100:0)
[08:38:56.246] Timer tick, asking Buildbucket for the build status
[08:38:56.469] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:56.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:101:0) after 1m0s
[08:39:56.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:101:0)
[08:39:56.540] Timer tick, asking Buildbucket for the build status
[08:39:56.696] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:56.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:102:0) after 1m0s
[08:40:56.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:102:0)
[08:40:56.745] Timer tick, asking Buildbucket for the build status
[08:40:56.927] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:56.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:103:0) after 1m0s
[08:41:56.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:103:0)
[08:41:56.982] Timer tick, asking Buildbucket for the build status
[08:41:57.269] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:57.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:104:0) after 1m0s
[08:42:57.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:104:0)
[08:42:57.318] Timer tick, asking Buildbucket for the build status
[08:42:57.687] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:57.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:105:0) after 1m0s
[08:43:57.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:105:0)
[08:43:57.708] Timer tick, asking Buildbucket for the build status
[08:43:58.273] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:58.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:106:0) after 1m0s
[08:44:58.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:106:0)
[08:44:58.299] Timer tick, asking Buildbucket for the build status
[08:44:58.410] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:58.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:107:0) after 1m0s
[08:45:58.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:107:0)
[08:45:58.439] Timer tick, asking Buildbucket for the build status
[08:45:58.586] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:58.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:108:0) after 1m0s
[08:46:58.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:108:0)
[08:46:58.622] Timer tick, asking Buildbucket for the build status
[08:46:58.793] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:58.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:109:0) after 1m0s
[08:47:58.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:109:0)
[08:47:58.831] Timer tick, asking Buildbucket for the build status
[08:47:59.332] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:59.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:110:0) after 1m0s
[08:48:59.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:110:0)
[08:48:59.356] Timer tick, asking Buildbucket for the build status
[08:49:00.266] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:00.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:111:0) after 1m0s
[08:50:00.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:111:0)
[08:50:00.347] Timer tick, asking Buildbucket for the build status
[08:50:00.990] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:00.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:112:0) after 1m0s
[08:51:01.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:112:0)
[08:51:01.047] Timer tick, asking Buildbucket for the build status
[08:51:01.176] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:01.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:113:0) after 1m0s
[08:52:01.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:113:0)
[08:52:01.613] Timer tick, asking Buildbucket for the build status
[08:52:02.064] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:02.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:114:0) after 1m0s
[08:53:02.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:114:0)
[08:53:02.135] Timer tick, asking Buildbucket for the build status
[08:53:02.355] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:02.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:115:0) after 1m0s
[08:54:02.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:115:0)
[08:54:02.455] Timer tick, asking Buildbucket for the build status
[08:54:02.583] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:02.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:116:0) after 1m0s
[08:55:02.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:116:0)
[08:55:02.632] Timer tick, asking Buildbucket for the build status
[08:55:02.759] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:02.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:117:0) after 1m0s
[08:56:02.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:117:0)
[08:56:02.794] Timer tick, asking Buildbucket for the build status
[08:56:03.166] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:03.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:118:0) after 1m0s
[08:57:03.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:118:0)
[08:57:03.195] Timer tick, asking Buildbucket for the build status
[08:57:03.612] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:03.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:119:0) after 1m0s
[08:58:03.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:119:0)
[08:58:03.669] Timer tick, asking Buildbucket for the build status
[08:58:03.856] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:03.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:120:0) after 1m0s
[08:59:03.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:120:0)
[08:59:03.879] Timer tick, asking Buildbucket for the build status
[08:59:04.208] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:04.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:121:0) after 1m0s
[09:00:04.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:121:0)
[09:00:04.239] Timer tick, asking Buildbucket for the build status
[09:00:04.613] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:04.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:122:0) after 1m0s
[09:01:04.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:122:0)
[09:01:04.628] Timer tick, asking Buildbucket for the build status
[09:01:04.929] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:04.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:123:0) after 1m0s
[09:02:05.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:123:0)
[09:02:05.058] Timer tick, asking Buildbucket for the build status
[09:02:05.202] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:05.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:124:0) after 1m0s
[09:03:05.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:124:0)
[09:03:05.266] Timer tick, asking Buildbucket for the build status
[09:03:05.642] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:05.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:125:0) after 1m0s
[09:04:05.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:125:0)
[09:04:05.704] Timer tick, asking Buildbucket for the build status
[09:04:06.098] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:06.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:126:0) after 1m0s
[09:05:06.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:126:0)
[09:05:06.313] Timer tick, asking Buildbucket for the build status
[09:05:06.519] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:06.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:127:0) after 1m0s
[09:06:06.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:127:0)
[09:06:06.629] Timer tick, asking Buildbucket for the build status
[09:06:07.062] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:07.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:128:0) after 1m0s
[09:07:07.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:128:0)
[09:07:07.137] Timer tick, asking Buildbucket for the build status
[09:07:07.338] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:07.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:129:0) after 1m0s
[09:08:07.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:129:0)
[09:08:07.388] Timer tick, asking Buildbucket for the build status
[09:08:08.170] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:08.170] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:130:0) after 1m0s
[09:09:08.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:130:0)
[09:09:08.245] Timer tick, asking Buildbucket for the build status
[09:09:08.460] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:08.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:131:0) after 1m0s
[09:10:08.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:131:0)
[09:10:08.496] Timer tick, asking Buildbucket for the build status
[09:10:08.624] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:08.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:132:0) after 1m0s
[09:11:08.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:132:0)
[09:11:08.669] Timer tick, asking Buildbucket for the build status
[09:11:08.878] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:08.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:133:0) after 1m0s
[09:12:08.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:133:0)
[09:12:08.949] Timer tick, asking Buildbucket for the build status
[09:12:09.868] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:09.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:134:0) after 1m0s
[09:13:09.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:134:0)
[09:13:09.966] Timer tick, asking Buildbucket for the build status
[09:13:11.225] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:11.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:135:0) after 1m0s
[09:14:11.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:135:0)
[09:14:11.289] Timer tick, asking Buildbucket for the build status
[09:14:11.542] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:11.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:136:0) after 1m0s
[09:15:11.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:136:0)
[09:15:11.605] Timer tick, asking Buildbucket for the build status
[09:15:11.762] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:11.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:137:0) after 1m0s
[09:16:11.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:137:0)
[09:16:11.890] Timer tick, asking Buildbucket for the build status
[09:16:12.636] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:12.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:138:0) after 1m0s
[09:17:12.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:138:0)
[09:17:12.695] Timer tick, asking Buildbucket for the build status
[09:17:13.656] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:13.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:139:0) after 1m0s
[09:18:13.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:139:0)
[09:18:13.694] Timer tick, asking Buildbucket for the build status
[09:18:14.157] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:14.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:140:0) after 1m0s
[09:19:14.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:140:0)
[09:19:14.271] Timer tick, asking Buildbucket for the build status
[09:19:14.590] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:14.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:141:0) after 1m0s
[09:20:14.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:141:0)
[09:20:14.653] Timer tick, asking Buildbucket for the build status
[09:20:14.882] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:14.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:142:0) after 1m0s
[09:21:14.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:142:0)
[09:21:14.968] Timer tick, asking Buildbucket for the build status
[09:21:15.173] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:15.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:143:0) after 1m0s
[09:22:15.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:143:0)
[09:22:15.218] Timer tick, asking Buildbucket for the build status
[09:22:16.132] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:16.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:144:0) after 1m0s
[09:23:16.305] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:144:0)
[09:23:16.305] Timer tick, asking Buildbucket for the build status
[09:23:16.481] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:16.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:145:0) after 1m0s
[09:24:16.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:145:0)
[09:24:16.651] Timer tick, asking Buildbucket for the build status
[09:24:16.804] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:16.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:146:0) after 1m0s
[09:25:17.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:146:0)
[09:25:17.077] Timer tick, asking Buildbucket for the build status
[09:25:17.242] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:17.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:147:0) after 1m0s
[09:26:17.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:147:0)
[09:26:17.426] Timer tick, asking Buildbucket for the build status
[09:26:17.617] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:17.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:148:0) after 1m0s
[09:27:17.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:148:0)
[09:27:17.862] Timer tick, asking Buildbucket for the build status
[09:27:18.073] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:18.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:149:0) after 1m0s
[09:28:18.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:149:0)
[09:28:18.283] Timer tick, asking Buildbucket for the build status
[09:28:18.414] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:18.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:150:0) after 1m0s
[09:29:18.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:150:0)
[09:29:18.599] Timer tick, asking Buildbucket for the build status
[09:29:18.778] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:18.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:151:0) after 1m0s
[09:30:18.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:151:0)
[09:30:18.865] Timer tick, asking Buildbucket for the build status
[09:30:19.338] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:19.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:152:0) after 1m0s
[09:31:19.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:152:0)
[09:31:19.511] Timer tick, asking Buildbucket for the build status
[09:31:20.642] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:20.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:153:0) after 1m0s
[09:32:20.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:153:0)
[09:32:20.835] Timer tick, asking Buildbucket for the build status
[09:32:20.990] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:20.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:154:0) after 1m0s
[09:33:21.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:154:0)
[09:33:21.223] Timer tick, asking Buildbucket for the build status
[09:33:21.402] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:21.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:155:0) after 1m0s
[09:34:21.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:155:0)
[09:34:21.529] Timer tick, asking Buildbucket for the build status
[09:34:22.065] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:22.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:156:0) after 1m0s
[09:35:22.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:156:0)
[09:35:22.106] Timer tick, asking Buildbucket for the build status
[09:35:22.425] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:22.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:157:0) after 1m0s
[09:36:22.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:157:0)
[09:36:22.526] Timer tick, asking Buildbucket for the build status
[09:36:22.725] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:22.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:158:0) after 1m0s
[09:37:22.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:158:0)
[09:37:22.749] Timer tick, asking Buildbucket for the build status
[09:37:23.048] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:23.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:159:0) after 1m0s
[09:38:23.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:159:0)
[09:38:23.224] Timer tick, asking Buildbucket for the build status
[09:38:23.353] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:23.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:160:0) after 1m0s
[09:39:23.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:160:0)
[09:39:23.430] Timer tick, asking Buildbucket for the build status
[09:39:23.907] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:23.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:161:0) after 1m0s
[09:40:23.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:161:0)
[09:40:23.976] Timer tick, asking Buildbucket for the build status
[09:40:24.137] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:24.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:162:0) after 1m0s
[09:41:24.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:162:0)
[09:41:24.161] Timer tick, asking Buildbucket for the build status
[09:41:24.366] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:24.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:163:0) after 1m0s
[09:42:24.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:163:0)
[09:42:24.393] Timer tick, asking Buildbucket for the build status
[09:42:24.835] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:24.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:164:0) after 1m0s
[09:43:24.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:164:0)
[09:43:24.948] Timer tick, asking Buildbucket for the build status
[09:43:25.253] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:25.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:165:0) after 1m0s
[09:44:25.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:165:0)
[09:44:25.321] Timer tick, asking Buildbucket for the build status
[09:44:25.640] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:25.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:166:0) after 1m0s
[09:45:25.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:166:0)
[09:45:25.724] Timer tick, asking Buildbucket for the build status
[09:45:25.874] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:25.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:167:0) after 1m0s
[09:46:25.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:167:0)
[09:46:25.997] Timer tick, asking Buildbucket for the build status
[09:46:26.257] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:26.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:168:0) after 1m0s
[09:47:26.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:168:0)
[09:47:26.376] Timer tick, asking Buildbucket for the build status
[09:47:26.527] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:26.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:169:0) after 1m0s
[09:48:26.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:169:0)
[09:48:26.616] Timer tick, asking Buildbucket for the build status
[09:48:26.730] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:26.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:170:0) after 1m0s
[09:49:26.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:170:0)
[09:49:26.812] Timer tick, asking Buildbucket for the build status
[09:49:27.274] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:27.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:171:0) after 1m0s
[09:50:27.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:171:0)
[09:50:27.374] Timer tick, asking Buildbucket for the build status
[09:50:27.881] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:27.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:172:0) after 1m0s
[09:51:27.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:172:0)
[09:51:27.931] Timer tick, asking Buildbucket for the build status
[09:51:28.049] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:28.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:173:0) after 1m0s
[09:52:28.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:173:0)
[09:52:28.144] Timer tick, asking Buildbucket for the build status
[09:52:28.826] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:28.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:174:0) after 1m0s
[09:53:28.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:174:0)
[09:53:28.876] Timer tick, asking Buildbucket for the build status
[09:53:29.052] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:29.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:175:0) after 1m0s
[09:54:29.100] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:175:0)
[09:54:29.100] Timer tick, asking Buildbucket for the build status
[09:54:29.367] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:29.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:176:0) after 1m0s
[09:55:29.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:176:0)
[09:55:29.391] Timer tick, asking Buildbucket for the build status
[09:55:29.821] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:29.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:177:0) after 1m0s
[09:56:29.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:177:0)
[09:56:29.840] Timer tick, asking Buildbucket for the build status
[09:56:29.963] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:29.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:178:0) after 1m0s
[09:57:29.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:178:0)
[09:57:29.998] Timer tick, asking Buildbucket for the build status
[09:57:30.240] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:30.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:179:0) after 1m0s
[09:58:30.310] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:179:0)
[09:58:30.310] Timer tick, asking Buildbucket for the build status
[09:58:30.510] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:30.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:180:0) after 1m0s
[09:59:30.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:180:0)
[09:59:30.569] Timer tick, asking Buildbucket for the build status
[09:59:30.685] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:30.685] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:181:0) after 1m0s
[10:00:30.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:181:0)
[10:00:30.669] Timer tick, asking Buildbucket for the build status
[10:00:31.285] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:31.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:182:0) after 1m0s
[10:01:31.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:182:0)
[10:01:31.356] Timer tick, asking Buildbucket for the build status
[10:01:31.537] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:31.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:183:0) after 1m0s
[10:02:31.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:183:0)
[10:02:31.617] Timer tick, asking Buildbucket for the build status
[10:02:31.825] Build 8878533559265532704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:31.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043963621286839344:184:0) after 1m0s
[10:02:57.895] Received PubSub notification, asking Buildbucket for the build status
[10:02:59.237] Build 8878533559265532704: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:02:59.237] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1591178576707340",
    "created_by": "project:infra",
    "created_ts": "1591167599385555",
    "id": "8878533559265532704",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4103.96\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e18ddf56-e0ce-471c-ab4a-5b5a1e1e0b68\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4103.96\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-au2m\"], \"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\": [\"5150-7dc5fa5\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1591167601885454",
    "status": "COMPLETED",
    "status_changed_ts": "1591178577269666",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9043963621286839344",
      "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/8878533559265532704/+/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:4c91cc4e646fbd10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1591178577358450",
    "url": "https://ci.chromium.org/b/8878533559265532704",
    "utcnow_ts": "1591178579052439"
  }
}
[10:02:59.237] Invocation finished in 3h3m1.162876515s with status SUCCEEDED