LUCI Scheduler :: infra :: Build From Tarball

Status: FAILED

Triggered by: chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com

Duration: 3 hours

Actions:

Definition (rev d0acf8648771c75c4d75c08daf9c0088a362343f)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.infra.cron"
  builder: "Build From Tarball"
>

Incoming triggers

publish_tarball/None (7 years ago by chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com)

Incoming properties

{
  "version": "72.0.3585.0"
}

Incoming tags

parent_buildername:publish_tarball
user_agent:recipe

Debug log (UTC)

[10:42:56.226] New invocation is queued and will start shortly
[10:42:56.226] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[10:42:57.455] Starting the invocation (attempt 1)
[10:42:57.522] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:42:57.522] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:42:57.522] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9097673594368824192",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"72.0.3585.0\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9097673594368824192",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[10:42:59.221] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1539945777614442",
    "id": "8932243532250401072",
    "lease_expiration_ts": "1540064578998041",
    "lease_key": "1625958488",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"72.0.3585.0\"}}",
    "project": "infra",
    "result_details_json": "null",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1539945779007493",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9097673594368824192",
      "scheduler_job_id:infra/Build From Tarball",
      "swarming_dimension:builder:Build From Tarball",
      "swarming_dimension:caches:builder_99d5fe30e8b6c78ca136ab5e547c67467b176b4f7d67cf49cf682cf48a330f19_v2",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.infra.cron",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:buildbucket_bucket:luci.infra.cron",
      "swarming_tag:buildbucket_build_id:8932243532250401072",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
      "swarming_tag:builder:Build From Tarball",
      "swarming_tag:caches:builder_99d5fe30e8b6c78ca136ab5e547c67467b176b4f7d67cf49cf682cf48a330f19_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8932243532250401072/+/annotations",
      "swarming_tag:luci_project:infra",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:parent_buildername:publish_tarball",
      "swarming_tag:pool:luci.infra.cron",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:build_from_tarball",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
      "swarming_tag:scheduler_invocation_id:9097673594368824192",
      "swarming_tag:scheduler_job_id:infra/Build From Tarball",
      "swarming_tag:service_account:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:86f8743ced46ac7ae8a49d5f70eecbcfd17feac4",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:user_agent:recipe",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:40a4bd55331ab610",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1539945779007757",
    "url": "https://ci.chromium.org/p/infra/builds/b8932243532250401072",
    "utcnow_ts": "1539945779194690"
  }
}
[10:42:59.221] Task URL: https://ci.chromium.org/p/infra/builds/b8932243532250401072
[10:42:59.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:2:0) after 1m0s
[10:43:06.819] Received PubSub notification, asking Buildbucket for the build status
[10:43:06.857] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:59.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:2:0)
[10:43:59.238] Timer tick, asking Buildbucket for the build status
[10:43:59.308] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:59.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:4:0) after 1m0s
[10:44:59.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:4:0)
[10:44:59.336] Timer tick, asking Buildbucket for the build status
[10:44:59.432] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:59.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:5:0) after 1m0s
[10:45:59.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:5:0)
[10:45:59.460] Timer tick, asking Buildbucket for the build status
[10:45:59.626] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:59.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:6:0) after 1m0s
[10:46:59.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:6:0)
[10:46:59.644] Timer tick, asking Buildbucket for the build status
[10:46:59.705] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:59.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:7:0) after 1m0s
[10:47:59.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:7:0)
[10:47:59.726] Timer tick, asking Buildbucket for the build status
[10:47:59.871] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:59.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:8:0) after 1m0s
[10:48:59.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:8:0)
[10:48:59.895] Timer tick, asking Buildbucket for the build status
[10:48:59.969] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:59.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:9:0) after 1m0s
[10:49:59.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:9:0)
[10:49:59.984] Timer tick, asking Buildbucket for the build status
[10:50:00.059] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:00.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:10:0) after 1m0s
[10:51:00.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:10:0)
[10:51:00.104] Timer tick, asking Buildbucket for the build status
[10:51:00.173] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:00.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:11:0) after 1m0s
[10:52:00.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:11:0)
[10:52:00.187] Timer tick, asking Buildbucket for the build status
[10:52:00.314] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:00.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:12:0) after 1m0s
[10:53:00.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:12:0)
[10:53:00.334] Timer tick, asking Buildbucket for the build status
[10:53:00.517] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:00.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:13:0) after 1m0s
[10:54:00.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:13:0)
[10:54:00.533] Timer tick, asking Buildbucket for the build status
[10:54:00.576] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:00.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:14:0) after 1m0s
[10:55:00.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:14:0)
[10:55:00.626] Timer tick, asking Buildbucket for the build status
[10:55:01.019] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:01.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:15:0) after 1m0s
[10:56:01.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:15:0)
[10:56:01.036] Timer tick, asking Buildbucket for the build status
[10:56:01.101] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:01.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:16:0) after 1m0s
[10:57:01.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:16:0)
[10:57:01.118] Timer tick, asking Buildbucket for the build status
[10:57:01.179] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:01.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:17:0) after 1m0s
[10:58:01.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:17:0)
[10:58:01.195] Timer tick, asking Buildbucket for the build status
[10:58:01.257] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:01.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:18:0) after 1m0s
[10:59:01.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:18:0)
[10:59:01.274] Timer tick, asking Buildbucket for the build status
[10:59:01.334] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:01.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:19:0) after 1m0s
[11:00:01.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:19:0)
[11:00:01.352] Timer tick, asking Buildbucket for the build status
[11:00:01.424] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:01.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:20:0) after 1m0s
[11:01:01.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:20:0)
[11:01:01.525] Timer tick, asking Buildbucket for the build status
[11:01:01.650] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:01.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:21:0) after 1m0s
[11:02:01.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:21:0)
[11:02:01.670] Timer tick, asking Buildbucket for the build status
[11:02:02.658] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:02.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:22:0) after 1m0s
[11:03:02.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:22:0)
[11:03:02.725] Timer tick, asking Buildbucket for the build status
[11:03:02.762] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:02.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:23:0) after 1m0s
[11:04:02.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:23:0)
[11:04:02.845] Timer tick, asking Buildbucket for the build status
[11:04:02.911] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:02.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:24:0) after 1m0s
[11:05:02.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:24:0)
[11:05:02.928] Timer tick, asking Buildbucket for the build status
[11:05:03.073] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:03.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:25:0) after 1m0s
[11:06:03.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:25:0)
[11:06:03.145] Timer tick, asking Buildbucket for the build status
[11:06:03.182] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:03.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:26:0) after 1m0s
[11:07:03.229] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:26:0)
[11:07:03.229] Timer tick, asking Buildbucket for the build status
[11:07:03.278] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:03.278] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:27:0) after 1m0s
[11:08:03.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:27:0)
[11:08:03.296] Timer tick, asking Buildbucket for the build status
[11:08:03.404] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:03.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:28:0) after 1m0s
[11:09:03.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:28:0)
[11:09:03.418] Timer tick, asking Buildbucket for the build status
[11:09:03.506] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:03.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:29:0) after 1m0s
[11:10:03.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:29:0)
[11:10:03.541] Timer tick, asking Buildbucket for the build status
[11:10:03.606] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:03.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:30:0) after 1m0s
[11:11:03.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:30:0)
[11:11:03.671] Timer tick, asking Buildbucket for the build status
[11:11:03.930] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:03.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:31:0) after 1m0s
[11:12:03.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:31:0)
[11:12:03.946] Timer tick, asking Buildbucket for the build status
[11:12:04.079] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:04.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:32:0) after 1m0s
[11:13:04.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:32:0)
[11:13:04.095] Timer tick, asking Buildbucket for the build status
[11:13:04.136] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:04.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:33:0) after 1m0s
[11:14:04.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:33:0)
[11:14:04.155] Timer tick, asking Buildbucket for the build status
[11:14:04.219] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:04.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:34:0) after 1m0s
[11:15:04.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:34:0)
[11:15:04.362] Timer tick, asking Buildbucket for the build status
[11:15:04.439] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:04.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:35:0) after 1m0s
[11:16:04.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:35:0)
[11:16:04.490] Timer tick, asking Buildbucket for the build status
[11:16:04.660] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:04.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:36:0) after 1m0s
[11:17:04.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:36:0)
[11:17:04.676] Timer tick, asking Buildbucket for the build status
[11:17:04.744] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:04.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:37:0) after 1m0s
[11:18:04.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:37:0)
[11:18:04.759] Timer tick, asking Buildbucket for the build status
[11:18:05.723] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:05.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:38:0) after 1m0s
[11:19:05.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:38:0)
[11:19:05.747] Timer tick, asking Buildbucket for the build status
[11:19:05.791] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:05.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:39:0) after 1m0s
[11:20:05.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:39:0)
[11:20:05.810] Timer tick, asking Buildbucket for the build status
[11:20:05.925] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:05.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:40:0) after 1m0s
[11:21:05.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:40:0)
[11:21:05.943] Timer tick, asking Buildbucket for the build status
[11:21:05.973] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:05.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:41:0) after 1m0s
[11:22:05.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:41:0)
[11:22:05.999] Timer tick, asking Buildbucket for the build status
[11:22:06.075] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:06.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:42:0) after 1m0s
[11:23:06.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:42:0)
[11:23:06.093] Timer tick, asking Buildbucket for the build status
[11:23:06.257] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:06.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:43:0) after 1m0s
[11:24:06.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:43:0)
[11:24:06.282] Timer tick, asking Buildbucket for the build status
[11:24:06.322] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:06.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:44:0) after 1m0s
[11:25:06.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:44:0)
[11:25:06.374] Timer tick, asking Buildbucket for the build status
[11:25:06.470] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:06.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:45:0) after 1m0s
[11:26:06.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:45:0)
[11:26:06.500] Timer tick, asking Buildbucket for the build status
[11:26:06.566] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:06.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:46:0) after 1m0s
[11:27:06.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:46:0)
[11:27:06.588] Timer tick, asking Buildbucket for the build status
[11:27:06.627] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:06.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:47:0) after 1m0s
[11:28:06.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:47:0)
[11:28:06.647] Timer tick, asking Buildbucket for the build status
[11:28:06.764] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:06.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:48:0) after 1m0s
[11:29:06.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:48:0)
[11:29:06.779] Timer tick, asking Buildbucket for the build status
[11:29:06.824] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:06.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:49:0) after 1m0s
[11:30:06.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:49:0)
[11:30:06.861] Timer tick, asking Buildbucket for the build status
[11:30:06.947] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:06.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:50:0) after 1m0s
[11:31:06.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:50:0)
[11:31:06.963] Timer tick, asking Buildbucket for the build status
[11:31:07.012] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:07.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:51:0) after 1m0s
[11:32:07.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:51:0)
[11:32:07.032] Timer tick, asking Buildbucket for the build status
[11:32:07.091] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:07.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:52:0) after 1m0s
[11:33:07.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:52:0)
[11:33:07.108] Timer tick, asking Buildbucket for the build status
[11:33:07.144] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:07.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:53:0) after 1m0s
[11:34:07.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:53:0)
[11:34:07.163] Timer tick, asking Buildbucket for the build status
[11:34:07.233] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:07.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:54:0) after 1m0s
[11:35:07.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:54:0)
[11:35:07.281] Timer tick, asking Buildbucket for the build status
[11:35:07.417] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:07.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:55:0) after 1m0s
[11:36:07.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:55:0)
[11:36:07.434] Timer tick, asking Buildbucket for the build status
[11:36:07.558] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:07.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:56:0) after 1m0s
[11:37:07.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:56:0)
[11:37:07.578] Timer tick, asking Buildbucket for the build status
[11:37:07.652] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:07.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:57:0) after 1m0s
[11:38:07.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:57:0)
[11:38:07.700] Timer tick, asking Buildbucket for the build status
[11:38:07.742] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:07.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:58:0) after 1m0s
[11:39:07.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:58:0)
[11:39:07.764] Timer tick, asking Buildbucket for the build status
[11:39:07.812] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:07.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:59:0) after 1m0s
[11:40:07.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:59:0)
[11:40:07.829] Timer tick, asking Buildbucket for the build status
[11:40:07.892] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:07.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:60:0) after 1m0s
[11:41:07.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:60:0)
[11:41:07.918] Timer tick, asking Buildbucket for the build status
[11:41:07.977] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:07.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:61:0) after 1m0s
[11:42:07.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:61:0)
[11:42:07.999] Timer tick, asking Buildbucket for the build status
[11:42:08.044] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:08.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:62:0) after 1m0s
[11:43:08.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:62:0)
[11:43:08.101] Timer tick, asking Buildbucket for the build status
[11:43:08.177] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:08.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:63:0) after 1m0s
[11:44:08.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:63:0)
[11:44:08.199] Timer tick, asking Buildbucket for the build status
[11:44:08.239] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:08.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:64:0) after 1m0s
[11:45:08.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:64:0)
[11:45:08.259] Timer tick, asking Buildbucket for the build status
[11:45:08.457] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:08.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:65:0) after 1m0s
[11:46:08.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:65:0)
[11:46:08.475] Timer tick, asking Buildbucket for the build status
[11:46:08.522] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:08.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:66:0) after 1m0s
[11:47:08.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:66:0)
[11:47:08.633] Timer tick, asking Buildbucket for the build status
[11:47:08.671] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:08.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:67:0) after 1m0s
[11:48:08.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:67:0)
[11:48:08.688] Timer tick, asking Buildbucket for the build status
[11:48:08.799] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:08.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:68:0) after 1m0s
[11:49:08.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:68:0)
[11:49:08.817] Timer tick, asking Buildbucket for the build status
[11:49:08.871] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:08.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:69:0) after 1m0s
[11:50:08.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:69:0)
[11:50:08.962] Timer tick, asking Buildbucket for the build status
[11:50:09.042] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:09.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:70:0) after 1m0s
[11:51:09.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:70:0)
[11:51:09.065] Timer tick, asking Buildbucket for the build status
[11:51:09.136] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:09.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:71:0) after 1m0s
[11:52:09.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:71:0)
[11:52:09.241] Timer tick, asking Buildbucket for the build status
[11:52:09.320] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:09.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:72:0) after 1m0s
[11:53:09.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:72:0)
[11:53:09.339] Timer tick, asking Buildbucket for the build status
[11:53:09.407] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:09.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:73:0) after 1m0s
[11:54:09.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:73:0)
[11:54:09.433] Timer tick, asking Buildbucket for the build status
[11:54:09.493] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:09.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:74:0) after 1m0s
[11:55:09.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:74:0)
[11:55:09.514] Timer tick, asking Buildbucket for the build status
[11:55:09.822] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:09.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:75:0) after 1m0s
[11:56:09.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:75:0)
[11:56:09.841] Timer tick, asking Buildbucket for the build status
[11:56:09.879] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:09.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:76:0) after 1m0s
[11:57:09.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:76:0)
[11:57:09.896] Timer tick, asking Buildbucket for the build status
[11:57:09.944] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:09.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:77:0) after 1m0s
[11:58:09.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:77:0)
[11:58:09.965] Timer tick, asking Buildbucket for the build status
[11:58:10.268] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:10.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:78:0) after 1m0s
[11:59:10.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:78:0)
[11:59:10.291] Timer tick, asking Buildbucket for the build status
[11:59:10.378] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:10.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:79:0) after 1m0s
[12:00:10.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:79:0)
[12:00:10.400] Timer tick, asking Buildbucket for the build status
[12:00:10.492] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:10.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:80:0) after 1m0s
[12:01:10.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:80:0)
[12:01:10.528] Timer tick, asking Buildbucket for the build status
[12:01:10.618] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:10.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:81:0) after 1m0s
[12:02:10.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:81:0)
[12:02:10.640] Timer tick, asking Buildbucket for the build status
[12:02:10.729] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:10.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:82:0) after 1m0s
[12:03:10.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:82:0)
[12:03:10.751] Timer tick, asking Buildbucket for the build status
[12:03:10.852] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:10.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:83:0) after 1m0s
[12:04:10.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:83:0)
[12:04:10.877] Timer tick, asking Buildbucket for the build status
[12:04:10.921] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:10.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:84:0) after 1m0s
[12:05:10.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:84:0)
[12:05:10.941] Timer tick, asking Buildbucket for the build status
[12:05:11.119] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:11.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:85:0) after 1m0s
[12:06:11.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:85:0)
[12:06:11.185] Timer tick, asking Buildbucket for the build status
[12:06:11.413] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:11.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:86:0) after 1m0s
[12:07:11.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:86:0)
[12:07:11.432] Timer tick, asking Buildbucket for the build status
[12:07:11.485] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:11.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:87:0) after 1m0s
[12:08:11.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:87:0)
[12:08:11.522] Timer tick, asking Buildbucket for the build status
[12:08:11.601] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:11.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:88:0) after 1m0s
[12:09:11.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:88:0)
[12:09:11.629] Timer tick, asking Buildbucket for the build status
[12:09:11.688] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:11.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:89:0) after 1m0s
[12:10:11.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:89:0)
[12:10:11.730] Timer tick, asking Buildbucket for the build status
[12:10:11.798] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:11.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:90:0) after 1m0s
[12:11:11.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:90:0)
[12:11:11.836] Timer tick, asking Buildbucket for the build status
[12:11:12.074] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:12.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:91:0) after 1m0s
[12:12:12.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:91:0)
[12:12:12.092] Timer tick, asking Buildbucket for the build status
[12:12:12.150] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:12.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:92:0) after 1m0s
[12:13:12.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:92:0)
[12:13:12.248] Timer tick, asking Buildbucket for the build status
[12:13:12.342] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:12.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:93:0) after 1m0s
[12:14:12.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:93:0)
[12:14:12.376] Timer tick, asking Buildbucket for the build status
[12:14:12.438] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:12.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:94:0) after 1m0s
[12:15:12.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:94:0)
[12:15:12.474] Timer tick, asking Buildbucket for the build status
[12:15:12.519] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:12.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:95:0) after 1m0s
[12:16:12.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:95:0)
[12:16:12.552] Timer tick, asking Buildbucket for the build status
[12:16:12.645] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:12.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:96:0) after 1m0s
[12:17:12.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:96:0)
[12:17:12.667] Timer tick, asking Buildbucket for the build status
[12:17:12.727] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:12.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:97:0) after 1m0s
[12:18:12.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:97:0)
[12:18:12.748] Timer tick, asking Buildbucket for the build status
[12:18:12.785] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:12.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:98:0) after 1m0s
[12:19:12.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:98:0)
[12:19:12.806] Timer tick, asking Buildbucket for the build status
[12:19:12.972] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:12.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:99:0) after 1m0s
[12:20:12.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:99:0)
[12:20:12.995] Timer tick, asking Buildbucket for the build status
[12:20:13.048] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:13.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:100:0) after 1m0s
[12:21:13.081] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:100:0)
[12:21:13.081] Timer tick, asking Buildbucket for the build status
[12:21:13.167] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:13.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:101:0) after 1m0s
[12:22:13.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:101:0)
[12:22:13.189] Timer tick, asking Buildbucket for the build status
[12:22:13.444] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:13.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:102:0) after 1m0s
[12:23:13.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:102:0)
[12:23:13.475] Timer tick, asking Buildbucket for the build status
[12:23:13.524] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:13.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:103:0) after 1m0s
[12:24:13.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:103:0)
[12:24:13.541] Timer tick, asking Buildbucket for the build status
[12:24:13.595] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:13.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:104:0) after 1m0s
[12:25:13.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:104:0)
[12:25:13.612] Timer tick, asking Buildbucket for the build status
[12:25:13.778] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:13.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:105:0) after 1m0s
[12:26:13.799] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:105:0)
[12:26:13.799] Timer tick, asking Buildbucket for the build status
[12:26:13.914] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:13.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:106:0) after 1m0s
[12:27:13.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:106:0)
[12:27:13.933] Timer tick, asking Buildbucket for the build status
[12:27:14.000] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:14.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:107:0) after 1m0s
[12:28:14.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:107:0)
[12:28:14.020] Timer tick, asking Buildbucket for the build status
[12:28:14.131] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:14.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:108:0) after 1m0s
[12:29:14.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:108:0)
[12:29:14.174] Timer tick, asking Buildbucket for the build status
[12:29:14.235] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:14.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:109:0) after 1m0s
[12:30:14.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:109:0)
[12:30:14.255] Timer tick, asking Buildbucket for the build status
[12:30:14.317] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:14.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:110:0) after 1m0s
[12:31:14.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:110:0)
[12:31:14.334] Timer tick, asking Buildbucket for the build status
[12:31:14.404] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:14.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:111:0) after 1m0s
[12:32:14.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:111:0)
[12:32:14.429] Timer tick, asking Buildbucket for the build status
[12:32:14.518] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:14.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:112:0) after 1m0s
[12:33:14.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:112:0)
[12:33:14.586] Timer tick, asking Buildbucket for the build status
[12:33:14.661] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:14.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:113:0) after 1m0s
[12:34:14.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:113:0)
[12:34:14.713] Timer tick, asking Buildbucket for the build status
[12:34:14.779] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:14.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:114:0) after 1m0s
[12:35:14.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:114:0)
[12:35:14.828] Timer tick, asking Buildbucket for the build status
[12:35:14.885] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:14.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:115:0) after 1m0s
[12:36:14.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:115:0)
[12:36:14.905] Timer tick, asking Buildbucket for the build status
[12:36:15.104] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:15.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:116:0) after 1m0s
[12:37:15.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:116:0)
[12:37:15.118] Timer tick, asking Buildbucket for the build status
[12:37:15.208] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:15.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:117:0) after 1m0s
[12:38:15.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:117:0)
[12:38:15.343] Timer tick, asking Buildbucket for the build status
[12:38:15.411] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:15.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:118:0) after 1m0s
[12:39:15.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:118:0)
[12:39:15.444] Timer tick, asking Buildbucket for the build status
[12:39:15.595] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:15.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:119:0) after 1m0s
[12:40:15.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:119:0)
[12:40:15.626] Timer tick, asking Buildbucket for the build status
[12:40:15.762] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:15.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:120:0) after 1m0s
[12:41:15.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:120:0)
[12:41:15.876] Timer tick, asking Buildbucket for the build status
[12:41:15.916] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:15.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:121:0) after 1m0s
[12:42:15.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:121:0)
[12:42:15.954] Timer tick, asking Buildbucket for the build status
[12:42:16.020] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:16.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:122:0) after 1m0s
[12:43:16.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:122:0)
[12:43:16.085] Timer tick, asking Buildbucket for the build status
[12:43:16.154] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:16.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:123:0) after 1m0s
[12:44:16.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:123:0)
[12:44:16.175] Timer tick, asking Buildbucket for the build status
[12:44:16.249] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:16.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:124:0) after 1m0s
[12:45:16.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:124:0)
[12:45:16.270] Timer tick, asking Buildbucket for the build status
[12:45:16.331] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:16.331] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:125:0) after 1m0s
[12:46:16.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:125:0)
[12:46:16.353] Timer tick, asking Buildbucket for the build status
[12:46:16.504] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:16.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:126:0) after 1m0s
[12:47:16.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:126:0)
[12:47:16.554] Timer tick, asking Buildbucket for the build status
[12:47:16.903] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:16.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:127:0) after 1m0s
[12:48:16.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:127:0)
[12:48:16.924] Timer tick, asking Buildbucket for the build status
[12:48:17.007] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:17.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:128:0) after 1m0s
[12:49:17.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:128:0)
[12:49:17.029] Timer tick, asking Buildbucket for the build status
[12:49:17.080] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:17.080] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:129:0) after 1m0s
[12:50:17.100] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:129:0)
[12:50:17.100] Timer tick, asking Buildbucket for the build status
[12:50:17.289] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:17.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:130:0) after 1m0s
[12:51:17.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:130:0)
[12:51:17.314] Timer tick, asking Buildbucket for the build status
[12:51:17.350] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:17.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:131:0) after 1m0s
[12:52:17.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:131:0)
[12:52:17.367] Timer tick, asking Buildbucket for the build status
[12:52:17.442] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:17.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:132:0) after 1m0s
[12:53:17.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:132:0)
[12:53:17.466] Timer tick, asking Buildbucket for the build status
[12:53:17.532] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:17.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:133:0) after 1m0s
[12:54:17.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:133:0)
[12:54:17.556] Timer tick, asking Buildbucket for the build status
[12:54:17.614] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:17.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:134:0) after 1m0s
[12:55:17.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:134:0)
[12:55:17.637] Timer tick, asking Buildbucket for the build status
[12:55:17.673] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:17.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:135:0) after 1m0s
[12:56:17.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:135:0)
[12:56:17.692] Timer tick, asking Buildbucket for the build status
[12:56:17.764] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:17.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:136:0) after 1m0s
[12:57:17.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:136:0)
[12:57:17.787] Timer tick, asking Buildbucket for the build status
[12:57:17.844] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:17.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:137:0) after 1m0s
[12:58:17.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:137:0)
[12:58:17.877] Timer tick, asking Buildbucket for the build status
[12:58:17.952] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:17.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:138:0) after 1m0s
[12:59:17.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:138:0)
[12:59:17.971] Timer tick, asking Buildbucket for the build status
[12:59:18.015] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:18.015] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:139:0) after 1m0s
[13:00:18.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:139:0)
[13:00:18.054] Timer tick, asking Buildbucket for the build status
[13:00:18.163] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:18.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:140:0) after 1m0s
[13:01:18.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:140:0)
[13:01:18.200] Timer tick, asking Buildbucket for the build status
[13:01:18.238] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:18.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:141:0) after 1m0s
[13:02:18.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:141:0)
[13:02:18.257] Timer tick, asking Buildbucket for the build status
[13:02:18.386] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:18.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:142:0) after 1m0s
[13:03:18.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:142:0)
[13:03:18.474] Timer tick, asking Buildbucket for the build status
[13:03:18.524] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:18.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:143:0) after 1m0s
[13:04:18.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:143:0)
[13:04:18.548] Timer tick, asking Buildbucket for the build status
[13:04:18.658] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:18.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:144:0) after 1m0s
[13:05:18.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:144:0)
[13:05:18.693] Timer tick, asking Buildbucket for the build status
[13:05:18.736] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:18.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:145:0) after 1m0s
[13:06:18.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:145:0)
[13:06:18.764] Timer tick, asking Buildbucket for the build status
[13:06:18.821] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:18.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:146:0) after 1m0s
[13:07:18.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:146:0)
[13:07:18.845] Timer tick, asking Buildbucket for the build status
[13:07:18.910] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:18.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:147:0) after 1m0s
[13:08:18.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:147:0)
[13:08:18.943] Timer tick, asking Buildbucket for the build status
[13:08:18.980] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:18.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:148:0) after 1m0s
[13:09:18.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:148:0)
[13:09:18.999] Timer tick, asking Buildbucket for the build status
[13:09:19.039] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:19.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:149:0) after 1m0s
[13:10:19.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:149:0)
[13:10:19.069] Timer tick, asking Buildbucket for the build status
[13:10:19.142] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:19.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:150:0) after 1m0s
[13:11:19.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:150:0)
[13:11:19.239] Timer tick, asking Buildbucket for the build status
[13:11:19.396] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:19.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:151:0) after 1m0s
[13:12:19.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:151:0)
[13:12:19.422] Timer tick, asking Buildbucket for the build status
[13:12:19.463] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:19.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:152:0) after 1m0s
[13:13:19.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:152:0)
[13:13:19.486] Timer tick, asking Buildbucket for the build status
[13:13:19.625] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:19.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:153:0) after 1m0s
[13:14:19.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:153:0)
[13:14:19.667] Timer tick, asking Buildbucket for the build status
[13:14:19.748] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:19.748] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:154:0) after 1m0s
[13:15:19.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:154:0)
[13:15:19.768] Timer tick, asking Buildbucket for the build status
[13:15:19.941] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:19.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:155:0) after 1m0s
[13:16:19.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:155:0)
[13:16:19.963] Timer tick, asking Buildbucket for the build status
[13:16:20.014] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:20.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:156:0) after 1m0s
[13:17:20.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:156:0)
[13:17:20.045] Timer tick, asking Buildbucket for the build status
[13:17:20.236] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:20.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:157:0) after 1m0s
[13:18:20.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:157:0)
[13:18:20.271] Timer tick, asking Buildbucket for the build status
[13:18:20.379] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:20.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:158:0) after 1m0s
[13:19:20.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:158:0)
[13:19:20.402] Timer tick, asking Buildbucket for the build status
[13:19:20.527] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:20.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:159:0) after 1m0s
[13:20:20.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:159:0)
[13:20:20.563] Timer tick, asking Buildbucket for the build status
[13:20:20.696] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:20.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:160:0) after 1m0s
[13:21:20.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:160:0)
[13:21:20.769] Timer tick, asking Buildbucket for the build status
[13:21:20.824] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:20.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:161:0) after 1m0s
[13:22:20.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:161:0)
[13:22:20.847] Timer tick, asking Buildbucket for the build status
[13:22:20.933] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:20.933] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:162:0) after 1m0s
[13:23:20.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:162:0)
[13:23:20.958] Timer tick, asking Buildbucket for the build status
[13:23:21.005] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:21.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:163:0) after 1m0s
[13:24:21.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:163:0)
[13:24:21.099] Timer tick, asking Buildbucket for the build status
[13:24:21.207] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:21.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:164:0) after 1m0s
[13:25:21.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:164:0)
[13:25:21.232] Timer tick, asking Buildbucket for the build status
[13:25:21.276] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:21.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:165:0) after 1m0s
[13:26:21.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:165:0)
[13:26:21.303] Timer tick, asking Buildbucket for the build status
[13:26:21.369] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:21.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:166:0) after 1m0s
[13:27:21.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:166:0)
[13:27:21.403] Timer tick, asking Buildbucket for the build status
[13:27:21.505] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:21.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:167:0) after 1m0s
[13:28:21.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:167:0)
[13:28:21.549] Timer tick, asking Buildbucket for the build status
[13:28:21.646] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:21.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:168:0) after 1m0s
[13:29:21.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:168:0)
[13:29:21.671] Timer tick, asking Buildbucket for the build status
[13:29:21.740] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:21.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:169:0) after 1m0s
[13:30:21.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:169:0)
[13:30:21.815] Timer tick, asking Buildbucket for the build status
[13:30:22.030] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:22.030] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:170:0) after 1m0s
[13:31:22.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:170:0)
[13:31:22.131] Timer tick, asking Buildbucket for the build status
[13:31:22.211] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:22.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:171:0) after 1m0s
[13:32:22.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:171:0)
[13:32:22.248] Timer tick, asking Buildbucket for the build status
[13:32:22.392] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:22.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:172:0) after 1m0s
[13:33:22.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:172:0)
[13:33:22.415] Timer tick, asking Buildbucket for the build status
[13:33:22.843] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:22.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:173:0) after 1m0s
[13:34:22.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:173:0)
[13:34:22.874] Timer tick, asking Buildbucket for the build status
[13:34:22.940] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:22.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:174:0) after 1m0s
[13:35:22.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:174:0)
[13:35:22.965] Timer tick, asking Buildbucket for the build status
[13:35:23.043] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:23.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:175:0) after 1m0s
[13:36:23.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:175:0)
[13:36:23.069] Timer tick, asking Buildbucket for the build status
[13:36:23.123] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:23.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:176:0) after 1m0s
[13:37:23.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:176:0)
[13:37:23.143] Timer tick, asking Buildbucket for the build status
[13:37:23.284] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:23.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:177:0) after 1m0s
[13:38:23.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:177:0)
[13:38:23.309] Timer tick, asking Buildbucket for the build status
[13:38:23.398] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:23.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:178:0) after 1m0s
[13:39:23.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:178:0)
[13:39:23.452] Timer tick, asking Buildbucket for the build status
[13:39:23.490] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:23.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:179:0) after 1m0s
[13:40:23.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:179:0)
[13:40:23.518] Timer tick, asking Buildbucket for the build status
[13:40:23.629] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:23.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:180:0) after 1m0s
[13:41:23.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:180:0)
[13:41:23.654] Timer tick, asking Buildbucket for the build status
[13:41:23.742] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:23.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:181:0) after 1m0s
[13:42:23.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:181:0)
[13:42:23.764] Timer tick, asking Buildbucket for the build status
[13:42:23.840] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:23.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:182:0) after 1m0s
[13:43:23.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:182:0)
[13:43:23.868] Timer tick, asking Buildbucket for the build status
[13:43:23.935] Build 8932243532250401072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:23.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097673594368824192:183:0) after 1m0s
[13:43:38.293] Received PubSub notification, asking Buildbucket for the build status
[13:43:38.504] Build 8932243532250401072: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[13:43:38.504] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "completed_ts": "1539956613085588",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1539945777614442",
    "failure_reason": "INFRA_FAILURE",
    "id": "8932243532250401072",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"72.0.3585.0\"}}",
    "project": "infra",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"\"}, \"build_run_result\": {\"infraFailure\": {\"text\": \"kitchen crashed or got killed\", \"bootstrapperCallStack\": [], \"type\": \"BOOTSTRAPPER_ERROR\"}, \"recipeResult\": null, \"recipeExitCode\": null, \"recipe\": null, \"annotationUrl\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Build From Tarball\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3809-a31bbe1\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-e833d7b0-us-west1-b-pvkn\"], \"pool\": [\"luci.infra.cron\"]}}, \"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1539945785994325",
    "status": "COMPLETED",
    "status_changed_ts": "1539956617802548",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9097673594368824192",
      "scheduler_job_id:infra/Build From Tarball",
      "swarming_dimension:builder:Build From Tarball",
      "swarming_dimension:caches:builder_99d5fe30e8b6c78ca136ab5e547c67467b176b4f7d67cf49cf682cf48a330f19_v2",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.infra.cron",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:buildbucket_bucket:luci.infra.cron",
      "swarming_tag:buildbucket_build_id:8932243532250401072",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
      "swarming_tag:builder:Build From Tarball",
      "swarming_tag:caches:builder_99d5fe30e8b6c78ca136ab5e547c67467b176b4f7d67cf49cf682cf48a330f19_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8932243532250401072/+/annotations",
      "swarming_tag:luci_project:infra",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:parent_buildername:publish_tarball",
      "swarming_tag:pool:luci.infra.cron",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:build_from_tarball",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
      "swarming_tag:scheduler_invocation_id:9097673594368824192",
      "swarming_tag:scheduler_job_id:infra/Build From Tarball",
      "swarming_tag:service_account:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:86f8743ced46ac7ae8a49d5f70eecbcfd17feac4",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:user_agent:recipe",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:40a4bd55331ab610",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1539956617851638",
    "url": "https://ci.chromium.org/p/infra/builds/b8932243532250401072",
    "utcnow_ts": "1539956618410594"
  }
}
[13:43:38.504] Invocation finished in 3h0m42.293065036s with status FAILED