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.4152.2"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[13:06:30.135] New invocation is queued and will start shortly
[13:06:30.135] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[13:06:31.226] Starting the invocation (attempt 1)
[13:06:31.266] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:06:31.266] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:06:31.266] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9044937127594844736",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4152.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"d366d16b-79fc-4f70-8542-eff11fb82976\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4152.2\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9044937127594844736",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[13:06:31.693] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1590239191346617",
    "id": "8879507065653373376",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4152.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"d366d16b-79fc-4f70-8542-eff11fb82976\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4152.2\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1590239191520967",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9044937127594844736",
      "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/8879507065653373376/+/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": "1590239191521091",
    "url": "https://ci.chromium.org/b/8879507065653373376",
    "utcnow_ts": "1590239191684985"
  }
}
[13:06:31.693] Task URL: https://ci.chromium.org/b/8879507065653373376
[13:06:31.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:2:0) after 1m0s
[13:07:31.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:2:0)
[13:07:31.715] Timer tick, asking Buildbucket for the build status
[13:07:31.826] Build 8879507065653373376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:07:31.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:3:0) after 1m0s
[13:08:31.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:3:0)
[13:08:31.846] Timer tick, asking Buildbucket for the build status
[13:08:32.154] Build 8879507065653373376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:08:32.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:4:0) after 1m0s
[13:09:32.171] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:4:0)
[13:09:32.171] Timer tick, asking Buildbucket for the build status
[13:09:32.281] Build 8879507065653373376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:09:32.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:5:0) after 1m0s
[13:10:32.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:5:0)
[13:10:32.366] Timer tick, asking Buildbucket for the build status
[13:10:32.542] Build 8879507065653373376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:10:32.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:6:0) after 1m0s
[13:11:32.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:6:0)
[13:11:32.573] Timer tick, asking Buildbucket for the build status
[13:11:32.708] Build 8879507065653373376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:11:32.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:7:0) after 1m0s
[13:12:32.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:7:0)
[13:12:32.777] Timer tick, asking Buildbucket for the build status
[13:12:32.891] Build 8879507065653373376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:12:32.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:8:0) after 1m0s
[13:13:33.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:8:0)
[13:13:33.013] Timer tick, asking Buildbucket for the build status
[13:13:33.391] Build 8879507065653373376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:13:33.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:9:0) after 1m0s
[13:14:33.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:9:0)
[13:14:33.437] Timer tick, asking Buildbucket for the build status
[13:14:33.554] Build 8879507065653373376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:14:33.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:10:0) after 1m0s
[13:14:57.171] Received PubSub notification, asking Buildbucket for the build status
[13:14:57.489] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:33.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:10:0)
[13:15:33.574] Timer tick, asking Buildbucket for the build status
[13:15:33.701] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:33.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:12:0) after 1m0s
[13:16:33.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:12:0)
[13:16:33.790] Timer tick, asking Buildbucket for the build status
[13:16:33.906] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:33.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:13:0) after 1m0s
[13:17:33.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:13:0)
[13:17:33.889] Timer tick, asking Buildbucket for the build status
[13:17:34.012] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:34.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:14:0) after 1m0s
[13:18:34.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:14:0)
[13:18:34.146] Timer tick, asking Buildbucket for the build status
[13:18:34.362] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:34.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:15:0) after 1m0s
[13:19:34.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:15:0)
[13:19:34.375] Timer tick, asking Buildbucket for the build status
[13:19:34.491] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:34.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:16:0) after 1m0s
[13:20:34.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:16:0)
[13:20:34.608] Timer tick, asking Buildbucket for the build status
[13:20:34.878] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:34.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:17:0) after 1m0s
[13:21:35.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:17:0)
[13:21:35.016] Timer tick, asking Buildbucket for the build status
[13:21:35.132] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:35.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:18:0) after 1m0s
[13:22:35.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:18:0)
[13:22:35.164] Timer tick, asking Buildbucket for the build status
[13:22:35.304] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:35.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:19:0) after 1m0s
[13:23:35.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:19:0)
[13:23:35.374] Timer tick, asking Buildbucket for the build status
[13:23:35.774] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:35.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:20:0) after 1m0s
[13:24:35.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:20:0)
[13:24:35.823] Timer tick, asking Buildbucket for the build status
[13:24:36.088] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:36.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:21:0) after 1m0s
[13:25:36.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:21:0)
[13:25:36.066] Timer tick, asking Buildbucket for the build status
[13:25:36.187] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:36.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:22:0) after 1m0s
[13:26:36.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:22:0)
[13:26:36.214] Timer tick, asking Buildbucket for the build status
[13:26:36.565] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:36.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:23:0) after 1m0s
[13:27:36.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:23:0)
[13:27:36.666] Timer tick, asking Buildbucket for the build status
[13:27:36.784] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:36.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:24:0) after 1m0s
[13:28:36.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:24:0)
[13:28:36.895] Timer tick, asking Buildbucket for the build status
[13:28:37.217] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:37.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:25:0) after 1m0s
[13:29:37.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:25:0)
[13:29:37.340] Timer tick, asking Buildbucket for the build status
[13:29:37.494] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:37.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:26:0) after 1m0s
[13:30:37.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:26:0)
[13:30:37.518] Timer tick, asking Buildbucket for the build status
[13:30:37.717] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:37.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:27:0) after 1m0s
[13:31:37.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:27:0)
[13:31:37.837] Timer tick, asking Buildbucket for the build status
[13:31:38.047] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:38.047] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:28:0) after 1m0s
[13:32:38.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:28:0)
[13:32:38.124] Timer tick, asking Buildbucket for the build status
[13:32:38.237] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:38.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:29:0) after 1m0s
[13:33:38.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:29:0)
[13:33:38.408] Timer tick, asking Buildbucket for the build status
[13:33:38.539] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:38.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:30:0) after 1m0s
[13:34:38.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:30:0)
[13:34:38.662] Timer tick, asking Buildbucket for the build status
[13:34:39.102] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:39.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:31:0) after 1m0s
[13:35:39.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:31:0)
[13:35:39.135] Timer tick, asking Buildbucket for the build status
[13:35:39.294] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:39.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:32:0) after 1m0s
[13:36:39.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:32:0)
[13:36:39.357] Timer tick, asking Buildbucket for the build status
[13:36:39.532] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:39.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:33:0) after 1m0s
[13:37:39.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:33:0)
[13:37:39.612] Timer tick, asking Buildbucket for the build status
[13:37:39.726] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:39.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:34:0) after 1m0s
[13:38:39.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:34:0)
[13:38:39.726] Timer tick, asking Buildbucket for the build status
[13:38:39.859] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:39.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:35:0) after 1m0s
[13:39:39.926] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:35:0)
[13:39:39.926] Timer tick, asking Buildbucket for the build status
[13:39:40.168] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:40.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:36:0) after 1m0s
[13:40:40.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:36:0)
[13:40:40.189] Timer tick, asking Buildbucket for the build status
[13:40:40.346] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:40.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:37:0) after 1m0s
[13:41:40.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:37:0)
[13:41:40.379] Timer tick, asking Buildbucket for the build status
[13:41:40.929] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:40.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:38:0) after 1m0s
[13:42:41.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:38:0)
[13:42:41.000] Timer tick, asking Buildbucket for the build status
[13:42:41.147] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:41.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:39:0) after 1m0s
[13:43:41.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:39:0)
[13:43:41.250] Timer tick, asking Buildbucket for the build status
[13:43:41.380] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:41.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:40:0) after 1m0s
[13:44:41.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:40:0)
[13:44:41.448] Timer tick, asking Buildbucket for the build status
[13:44:42.063] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:42.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:41:0) after 1m0s
[13:45:42.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:41:0)
[13:45:42.152] Timer tick, asking Buildbucket for the build status
[13:45:42.781] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:42.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:42:0) after 1m0s
[13:46:42.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:42:0)
[13:46:42.925] Timer tick, asking Buildbucket for the build status
[13:46:43.083] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:43.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:43:0) after 1m0s
[13:47:43.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:43:0)
[13:47:43.128] Timer tick, asking Buildbucket for the build status
[13:47:43.426] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:43.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:44:0) after 1m0s
[13:48:43.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:44:0)
[13:48:43.520] Timer tick, asking Buildbucket for the build status
[13:48:43.653] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:43.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:45:0) after 1m0s
[13:49:43.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:45:0)
[13:49:43.785] Timer tick, asking Buildbucket for the build status
[13:49:43.930] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:43.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:46:0) after 1m0s
[13:50:44.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:46:0)
[13:50:44.002] Timer tick, asking Buildbucket for the build status
[13:50:44.147] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:44.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:47:0) after 1m0s
[13:51:44.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:47:0)
[13:51:44.204] Timer tick, asking Buildbucket for the build status
[13:51:44.340] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:44.340] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:48:0) after 1m0s
[13:52:44.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:48:0)
[13:52:44.384] Timer tick, asking Buildbucket for the build status
[13:52:44.769] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:44.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:49:0) after 1m0s
[13:53:44.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:49:0)
[13:53:44.812] Timer tick, asking Buildbucket for the build status
[13:53:44.994] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:44.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:50:0) after 1m0s
[13:54:45.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:50:0)
[13:54:45.075] Timer tick, asking Buildbucket for the build status
[13:54:45.288] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:45.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:51:0) after 1m0s
[13:55:45.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:51:0)
[13:55:45.433] Timer tick, asking Buildbucket for the build status
[13:55:45.741] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:45.741] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:52:0) after 1m0s
[13:56:45.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:52:0)
[13:56:45.953] Timer tick, asking Buildbucket for the build status
[13:56:46.172] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:46.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:53:0) after 1m0s
[13:57:46.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:53:0)
[13:57:46.205] Timer tick, asking Buildbucket for the build status
[13:57:46.321] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:46.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:54:0) after 1m0s
[13:58:46.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:54:0)
[13:58:46.521] Timer tick, asking Buildbucket for the build status
[13:58:46.754] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:46.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:55:0) after 1m0s
[13:59:46.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:55:0)
[13:59:46.882] Timer tick, asking Buildbucket for the build status
[13:59:47.027] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:47.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:56:0) after 1m0s
[14:00:47.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:56:0)
[14:00:47.209] Timer tick, asking Buildbucket for the build status
[14:00:47.399] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:47.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:57:0) after 1m0s
[14:01:47.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:57:0)
[14:01:47.470] Timer tick, asking Buildbucket for the build status
[14:01:47.830] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:47.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:58:0) after 1m0s
[14:02:47.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:58:0)
[14:02:47.995] Timer tick, asking Buildbucket for the build status
[14:02:48.151] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:48.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:59:0) after 1m0s
[14:03:48.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:59:0)
[14:03:48.323] Timer tick, asking Buildbucket for the build status
[14:03:48.507] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:48.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:60:0) after 1m0s
[14:04:48.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:60:0)
[14:04:48.695] Timer tick, asking Buildbucket for the build status
[14:04:48.831] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:48.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:61:0) after 1m0s
[14:05:48.926] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:61:0)
[14:05:48.926] Timer tick, asking Buildbucket for the build status
[14:05:49.694] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:49.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:62:0) after 1m0s
[14:06:49.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:62:0)
[14:06:49.686] Timer tick, asking Buildbucket for the build status
[14:06:49.809] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:49.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:63:0) after 1m0s
[14:07:49.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:63:0)
[14:07:49.786] Timer tick, asking Buildbucket for the build status
[14:07:49.908] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:49.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:64:0) after 1m0s
[14:08:49.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:64:0)
[14:08:49.935] Timer tick, asking Buildbucket for the build status
[14:08:50.141] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:50.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:65:0) after 1m0s
[14:09:50.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:65:0)
[14:09:50.187] Timer tick, asking Buildbucket for the build status
[14:09:50.607] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:50.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:66:0) after 1m0s
[14:10:50.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:66:0)
[14:10:50.658] Timer tick, asking Buildbucket for the build status
[14:10:50.773] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:50.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:67:0) after 1m0s
[14:11:50.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:67:0)
[14:11:50.747] Timer tick, asking Buildbucket for the build status
[14:11:50.926] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:50.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:68:0) after 1m0s
[14:12:51.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:68:0)
[14:12:51.000] Timer tick, asking Buildbucket for the build status
[14:12:51.163] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:51.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:69:0) after 1m0s
[14:13:51.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:69:0)
[14:13:51.358] Timer tick, asking Buildbucket for the build status
[14:13:51.476] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:51.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:70:0) after 1m0s
[14:14:51.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:70:0)
[14:14:51.766] Timer tick, asking Buildbucket for the build status
[14:14:51.893] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:51.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:71:0) after 1m0s
[14:15:52.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:71:0)
[14:15:52.176] Timer tick, asking Buildbucket for the build status
[14:15:52.733] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:52.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:72:0) after 1m0s
[14:16:52.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:72:0)
[14:16:52.821] Timer tick, asking Buildbucket for the build status
[14:16:53.212] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:53.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:73:0) after 1m0s
[14:17:53.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:73:0)
[14:17:53.444] Timer tick, asking Buildbucket for the build status
[14:17:53.562] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:53.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:74:0) after 1m0s
[14:18:53.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:74:0)
[14:18:53.676] Timer tick, asking Buildbucket for the build status
[14:18:54.138] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:54.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:75:0) after 1m0s
[14:19:54.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:75:0)
[14:19:54.218] Timer tick, asking Buildbucket for the build status
[14:19:54.408] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:54.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:76:0) after 1m0s
[14:20:54.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:76:0)
[14:20:54.481] Timer tick, asking Buildbucket for the build status
[14:20:54.931] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:54.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:77:0) after 1m0s
[14:21:54.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:77:0)
[14:21:54.994] Timer tick, asking Buildbucket for the build status
[14:21:55.549] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:55.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:78:0) after 1m0s
[14:22:55.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:78:0)
[14:22:55.580] Timer tick, asking Buildbucket for the build status
[14:22:55.956] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:55.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:79:0) after 1m0s
[14:23:56.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:79:0)
[14:23:56.032] Timer tick, asking Buildbucket for the build status
[14:23:56.144] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:56.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:80:0) after 1m0s
[14:24:56.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:80:0)
[14:24:56.255] Timer tick, asking Buildbucket for the build status
[14:24:56.400] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:56.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:81:0) after 1m0s
[14:25:56.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:81:0)
[14:25:56.711] Timer tick, asking Buildbucket for the build status
[14:25:56.842] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:56.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:82:0) after 1m0s
[14:26:56.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:82:0)
[14:26:56.955] Timer tick, asking Buildbucket for the build status
[14:26:57.086] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:57.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:83:0) after 1m0s
[14:27:57.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:83:0)
[14:27:57.268] Timer tick, asking Buildbucket for the build status
[14:27:57.752] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:57.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:84:0) after 1m0s
[14:28:57.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:84:0)
[14:28:57.776] Timer tick, asking Buildbucket for the build status
[14:28:57.946] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:57.946] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:85:0) after 1m0s
[14:29:58.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:85:0)
[14:29:58.044] Timer tick, asking Buildbucket for the build status
[14:29:58.367] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:58.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:86:0) after 1m0s
[14:30:58.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:86:0)
[14:30:58.422] Timer tick, asking Buildbucket for the build status
[14:30:58.566] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:58.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:87:0) after 1m0s
[14:31:58.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:87:0)
[14:31:58.694] Timer tick, asking Buildbucket for the build status
[14:31:58.852] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:58.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:88:0) after 1m0s
[14:32:59.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:88:0)
[14:32:59.095] Timer tick, asking Buildbucket for the build status
[14:32:59.342] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:59.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:89:0) after 1m0s
[14:33:59.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:89:0)
[14:33:59.651] Timer tick, asking Buildbucket for the build status
[14:33:59.966] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:59.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:90:0) after 1m0s
[14:35:00.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:90:0)
[14:35:00.000] Timer tick, asking Buildbucket for the build status
[14:35:00.185] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:00.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:91:0) after 1m0s
[14:36:00.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:91:0)
[14:36:00.261] Timer tick, asking Buildbucket for the build status
[14:36:00.858] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:00.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:92:0) after 1m0s
[14:37:00.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:92:0)
[14:37:00.958] Timer tick, asking Buildbucket for the build status
[14:37:01.118] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:01.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:93:0) after 1m0s
[14:38:01.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:93:0)
[14:38:01.861] Timer tick, asking Buildbucket for the build status
[14:38:02.155] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:02.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:94:0) after 1m0s
[14:39:02.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:94:0)
[14:39:02.878] Timer tick, asking Buildbucket for the build status
[14:39:03.436] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:03.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:95:0) after 1m0s
[14:40:03.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:95:0)
[14:40:03.545] Timer tick, asking Buildbucket for the build status
[14:40:03.650] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:03.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:96:0) after 1m0s
[14:41:03.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:96:0)
[14:41:03.773] Timer tick, asking Buildbucket for the build status
[14:41:05.522] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:05.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:97:0) after 1m0s
[14:42:05.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:97:0)
[14:42:05.788] Timer tick, asking Buildbucket for the build status
[14:42:06.004] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:06.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:98:0) after 1m0s
[14:43:06.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:98:0)
[14:43:06.038] Timer tick, asking Buildbucket for the build status
[14:43:06.396] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:06.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:99:0) after 1m0s
[14:44:06.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:99:0)
[14:44:06.468] Timer tick, asking Buildbucket for the build status
[14:44:06.746] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:06.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:100:0) after 1m0s
[14:45:06.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:100:0)
[14:45:06.789] Timer tick, asking Buildbucket for the build status
[14:45:06.952] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:06.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:101:0) after 1m0s
[14:46:06.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:101:0)
[14:46:06.993] Timer tick, asking Buildbucket for the build status
[14:46:07.153] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:07.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:102:0) after 1m0s
[14:47:07.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:102:0)
[14:47:07.198] Timer tick, asking Buildbucket for the build status
[14:47:07.432] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:07.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:103:0) after 1m0s
[14:48:07.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:103:0)
[14:48:07.506] Timer tick, asking Buildbucket for the build status
[14:48:07.629] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:07.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:104:0) after 1m0s
[14:49:07.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:104:0)
[14:49:07.698] Timer tick, asking Buildbucket for the build status
[14:49:07.899] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:07.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:105:0) after 1m0s
[14:50:07.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:105:0)
[14:50:07.925] Timer tick, asking Buildbucket for the build status
[14:50:08.801] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:08.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:106:0) after 1m0s
[14:51:08.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:106:0)
[14:51:08.893] Timer tick, asking Buildbucket for the build status
[14:51:09.049] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:09.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:107:0) after 1m0s
[14:52:09.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:107:0)
[14:52:09.200] Timer tick, asking Buildbucket for the build status
[14:52:09.511] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:09.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:108:0) after 1m0s
[14:53:09.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:108:0)
[14:53:09.619] Timer tick, asking Buildbucket for the build status
[14:53:09.810] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:09.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:109:0) after 1m0s
[14:54:09.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:109:0)
[14:54:09.873] Timer tick, asking Buildbucket for the build status
[14:54:10.337] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:10.337] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:110:0) after 1m0s
[14:55:10.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:110:0)
[14:55:10.372] Timer tick, asking Buildbucket for the build status
[14:55:10.553] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:10.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:111:0) after 1m0s
[14:56:10.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:111:0)
[14:56:10.648] Timer tick, asking Buildbucket for the build status
[14:56:11.185] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:11.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:112:0) after 1m0s
[14:57:11.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:112:0)
[14:57:11.267] Timer tick, asking Buildbucket for the build status
[14:57:11.558] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:11.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:113:0) after 1m0s
[14:58:11.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:113:0)
[14:58:11.725] Timer tick, asking Buildbucket for the build status
[14:58:12.786] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:12.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:114:0) after 1m0s
[14:59:12.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:114:0)
[14:59:12.870] Timer tick, asking Buildbucket for the build status
[14:59:13.029] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:13.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:115:0) after 1m0s
[15:00:13.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:115:0)
[15:00:13.730] Timer tick, asking Buildbucket for the build status
[15:00:14.025] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:14.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:116:0) after 1m0s
[15:01:14.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:116:0)
[15:01:14.067] Timer tick, asking Buildbucket for the build status
[15:01:14.355] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:14.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:117:0) after 1m0s
[15:02:14.399] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:117:0)
[15:02:14.399] Timer tick, asking Buildbucket for the build status
[15:02:14.558] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:14.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:118:0) after 1m0s
[15:03:14.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:118:0)
[15:03:14.579] Timer tick, asking Buildbucket for the build status
[15:03:15.257] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:15.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:119:0) after 1m0s
[15:04:15.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:119:0)
[15:04:15.333] Timer tick, asking Buildbucket for the build status
[15:04:15.443] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:15.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:120:0) after 1m0s
[15:05:15.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:120:0)
[15:05:15.439] Timer tick, asking Buildbucket for the build status
[15:05:15.564] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:15.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:121:0) after 1m0s
[15:06:15.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:121:0)
[15:06:15.593] Timer tick, asking Buildbucket for the build status
[15:06:15.898] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:15.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:122:0) after 1m0s
[15:07:16.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:122:0)
[15:07:16.009] Timer tick, asking Buildbucket for the build status
[15:07:16.161] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:16.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:123:0) after 1m0s
[15:08:16.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:123:0)
[15:08:16.231] Timer tick, asking Buildbucket for the build status
[15:08:16.403] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:16.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:124:0) after 1m0s
[15:09:16.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:124:0)
[15:09:16.489] Timer tick, asking Buildbucket for the build status
[15:09:17.063] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:17.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:125:0) after 1m0s
[15:10:17.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:125:0)
[15:10:17.098] Timer tick, asking Buildbucket for the build status
[15:10:17.306] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:17.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:126:0) after 1m0s
[15:11:17.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:126:0)
[15:11:17.365] Timer tick, asking Buildbucket for the build status
[15:11:17.492] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:17.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:127:0) after 1m0s
[15:12:17.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:127:0)
[15:12:17.619] Timer tick, asking Buildbucket for the build status
[15:12:18.039] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:18.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:128:0) after 1m0s
[15:13:18.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:128:0)
[15:13:18.132] Timer tick, asking Buildbucket for the build status
[15:13:18.285] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:18.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:129:0) after 1m0s
[15:14:18.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:129:0)
[15:14:18.374] Timer tick, asking Buildbucket for the build status
[15:14:18.528] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:18.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:130:0) after 1m0s
[15:15:18.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:130:0)
[15:15:18.612] Timer tick, asking Buildbucket for the build status
[15:15:18.750] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:18.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:131:0) after 1m0s
[15:16:18.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:131:0)
[15:16:18.783] Timer tick, asking Buildbucket for the build status
[15:16:18.913] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:18.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:132:0) after 1m0s
[15:17:18.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:132:0)
[15:17:18.959] Timer tick, asking Buildbucket for the build status
[15:17:19.107] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:19.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:133:0) after 1m0s
[15:18:19.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:133:0)
[15:18:19.124] Timer tick, asking Buildbucket for the build status
[15:18:19.826] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:19.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:134:0) after 1m0s
[15:19:19.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:134:0)
[15:19:19.863] Timer tick, asking Buildbucket for the build status
[15:19:19.971] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:19.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:135:0) after 1m0s
[15:20:20.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:135:0)
[15:20:20.017] Timer tick, asking Buildbucket for the build status
[15:20:20.365] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:20.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:136:0) after 1m0s
[15:21:20.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:136:0)
[15:21:20.405] Timer tick, asking Buildbucket for the build status
[15:21:20.637] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:20.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:137:0) after 1m0s
[15:22:20.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:137:0)
[15:22:20.693] Timer tick, asking Buildbucket for the build status
[15:22:20.919] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:20.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:138:0) after 1m0s
[15:23:20.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:138:0)
[15:23:20.945] Timer tick, asking Buildbucket for the build status
[15:23:21.802] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:21.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:139:0) after 1m0s
[15:24:21.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:139:0)
[15:24:21.839] Timer tick, asking Buildbucket for the build status
[15:24:22.238] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:22.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:140:0) after 1m0s
[15:25:22.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:140:0)
[15:25:22.273] Timer tick, asking Buildbucket for the build status
[15:25:22.522] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:22.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:141:0) after 1m0s
[15:26:22.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:141:0)
[15:26:22.558] Timer tick, asking Buildbucket for the build status
[15:26:23.953] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:23.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:142:0) after 1m0s
[15:27:24.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:142:0)
[15:27:24.061] Timer tick, asking Buildbucket for the build status
[15:27:24.215] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:24.215] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:143:0) after 1m0s
[15:28:24.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:143:0)
[15:28:24.232] Timer tick, asking Buildbucket for the build status
[15:28:24.403] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:24.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:144:0) after 1m0s
[15:29:24.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:144:0)
[15:29:24.479] Timer tick, asking Buildbucket for the build status
[15:29:24.870] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:24.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:145:0) after 1m0s
[15:30:24.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:145:0)
[15:30:24.910] Timer tick, asking Buildbucket for the build status
[15:30:25.112] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:25.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:146:0) after 1m0s
[15:31:25.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:146:0)
[15:31:25.158] Timer tick, asking Buildbucket for the build status
[15:31:25.326] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:25.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:147:0) after 1m0s
[15:32:25.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:147:0)
[15:32:25.403] Timer tick, asking Buildbucket for the build status
[15:32:25.863] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:25.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:148:0) after 1m0s
[15:33:25.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:148:0)
[15:33:25.898] Timer tick, asking Buildbucket for the build status
[15:33:26.014] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:26.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:149:0) after 1m0s
[15:34:26.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:149:0)
[15:34:26.075] Timer tick, asking Buildbucket for the build status
[15:34:26.379] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:26.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:150:0) after 1m0s
[15:35:26.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:150:0)
[15:35:26.405] Timer tick, asking Buildbucket for the build status
[15:35:26.590] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:26.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:151:0) after 1m0s
[15:36:26.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:151:0)
[15:36:26.631] Timer tick, asking Buildbucket for the build status
[15:36:26.991] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:26.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:152:0) after 1m0s
[15:37:27.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:152:0)
[15:37:27.022] Timer tick, asking Buildbucket for the build status
[15:37:27.303] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:27.303] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:153:0) after 1m0s
[15:38:27.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:153:0)
[15:38:27.379] Timer tick, asking Buildbucket for the build status
[15:38:27.586] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:27.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:154:0) after 1m0s
[15:39:27.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:154:0)
[15:39:27.617] Timer tick, asking Buildbucket for the build status
[15:39:27.787] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:27.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:155:0) after 1m0s
[15:40:27.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:155:0)
[15:40:27.837] Timer tick, asking Buildbucket for the build status
[15:40:27.993] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:27.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:156:0) after 1m0s
[15:41:28.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:156:0)
[15:41:28.025] Timer tick, asking Buildbucket for the build status
[15:41:28.155] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:28.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:157:0) after 1m0s
[15:42:28.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:157:0)
[15:42:28.194] Timer tick, asking Buildbucket for the build status
[15:42:28.375] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:28.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:158:0) after 1m0s
[15:43:28.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:158:0)
[15:43:28.413] Timer tick, asking Buildbucket for the build status
[15:43:28.529] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:28.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:159:0) after 1m0s
[15:44:28.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:159:0)
[15:44:28.566] Timer tick, asking Buildbucket for the build status
[15:44:28.871] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:28.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:160:0) after 1m0s
[15:45:28.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:160:0)
[15:45:28.897] Timer tick, asking Buildbucket for the build status
[15:45:29.253] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:29.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:161:0) after 1m0s
[15:46:29.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:161:0)
[15:46:29.331] Timer tick, asking Buildbucket for the build status
[15:46:29.470] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:29.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:162:0) after 1m0s
[15:47:29.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:162:0)
[15:47:29.498] Timer tick, asking Buildbucket for the build status
[15:47:29.653] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:29.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:163:0) after 1m0s
[15:48:29.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:163:0)
[15:48:29.727] Timer tick, asking Buildbucket for the build status
[15:48:29.881] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:29.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:164:0) after 1m0s
[15:49:29.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:164:0)
[15:49:29.916] Timer tick, asking Buildbucket for the build status
[15:49:30.110] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:30.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:165:0) after 1m0s
[15:50:30.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:165:0)
[15:50:30.205] Timer tick, asking Buildbucket for the build status
[15:50:30.394] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:30.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:166:0) after 1m0s
[15:51:30.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:166:0)
[15:51:30.448] Timer tick, asking Buildbucket for the build status
[15:51:30.574] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:30.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:167:0) after 1m0s
[15:52:30.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:167:0)
[15:52:30.601] Timer tick, asking Buildbucket for the build status
[15:52:31.141] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:31.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:168:0) after 1m0s
[15:53:31.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:168:0)
[15:53:31.218] Timer tick, asking Buildbucket for the build status
[15:53:31.428] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:31.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:169:0) after 1m0s
[15:54:31.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:169:0)
[15:54:31.494] Timer tick, asking Buildbucket for the build status
[15:54:31.641] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:31.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:170:0) after 1m0s
[15:55:31.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:170:0)
[15:55:31.863] Timer tick, asking Buildbucket for the build status
[15:55:31.993] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:31.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:171:0) after 1m0s
[15:56:32.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:171:0)
[15:56:32.015] Timer tick, asking Buildbucket for the build status
[15:56:32.205] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:32.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:172:0) after 1m0s
[15:57:32.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:172:0)
[15:57:32.236] Timer tick, asking Buildbucket for the build status
[15:57:32.732] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:32.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:173:0) after 1m0s
[15:58:32.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:173:0)
[15:58:32.812] Timer tick, asking Buildbucket for the build status
[15:58:33.053] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:33.053] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:174:0) after 1m0s
[15:59:33.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:174:0)
[15:59:33.182] Timer tick, asking Buildbucket for the build status
[15:59:33.328] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:33.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:175:0) after 1m0s
[16:00:33.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:175:0)
[16:00:33.487] Timer tick, asking Buildbucket for the build status
[16:00:33.938] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:33.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:176:0) after 1m0s
[16:01:34.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:176:0)
[16:01:34.002] Timer tick, asking Buildbucket for the build status
[16:01:34.478] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:34.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:177:0) after 1m0s
[16:02:34.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:177:0)
[16:02:34.507] Timer tick, asking Buildbucket for the build status
[16:02:34.992] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:34.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:178:0) after 1m0s
[16:03:35.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:178:0)
[16:03:35.144] Timer tick, asking Buildbucket for the build status
[16:03:35.431] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:35.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:179:0) after 1m0s
[16:04:35.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:179:0)
[16:04:35.526] Timer tick, asking Buildbucket for the build status
[16:04:35.704] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:35.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:180:0) after 1m0s
[16:05:35.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:180:0)
[16:05:35.700] Timer tick, asking Buildbucket for the build status
[16:05:35.812] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:35.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:181:0) after 1m0s
[16:06:35.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:181:0)
[16:06:35.839] Timer tick, asking Buildbucket for the build status
[16:06:36.004] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:36.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:182:0) after 1m0s
[16:07:36.080] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:182:0)
[16:07:36.080] Timer tick, asking Buildbucket for the build status
[16:07:36.348] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:36.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:183:0) after 1m0s
[16:08:36.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:183:0)
[16:08:36.392] Timer tick, asking Buildbucket for the build status
[16:08:36.836] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:36.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:184:0) after 1m0s
[16:09:36.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:184:0)
[16:09:36.933] Timer tick, asking Buildbucket for the build status
[16:09:37.383] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:37.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:185:0) after 1m0s
[16:10:37.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:185:0)
[16:10:37.431] Timer tick, asking Buildbucket for the build status
[16:10:37.624] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:37.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:186:0) after 1m0s
[16:11:37.630] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:186:0)
[16:11:37.630] Timer tick, asking Buildbucket for the build status
[16:11:37.974] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:37.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:187:0) after 1m0s
[16:12:38.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:187:0)
[16:12:38.124] Timer tick, asking Buildbucket for the build status
[16:12:38.258] Build 8879507065653373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:38.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044937127594844736:188:0) after 1m0s
[16:12:53.048] Received PubSub notification, asking Buildbucket for the build status
[16:12:53.145] Build 8879507065653373376: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:12:53.145] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1590250372024467",
    "created_by": "project:infra",
    "created_ts": "1590239191346617",
    "id": "8879507065653373376",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4152.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"d366d16b-79fc-4f70-8542-eff11fb82976\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4152.2\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4152.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"d366d16b-79fc-4f70-8542-eff11fb82976\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-0o9h\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"85.0.4152.2\"}, \"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-0o9h\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"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\": [\"5100-d2625c1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1590239696181692",
    "status": "COMPLETED",
    "status_changed_ts": "1590250372481130",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9044937127594844736",
      "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/8879507065653373376/+/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:4c5a75ecaa5e2510",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1590250372580467",
    "url": "https://ci.chromium.org/b/8879507065653373376",
    "utcnow_ts": "1590250373136010"
  }
}
[16:12:53.145] Invocation finished in 3h6m23.033478712s with status SUCCEEDED