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

Incoming tags

parent_buildername:publish_tarball
user_agent:recipe

Debug log (UTC)

[10:31:20.225] New invocation is queued and will start shortly
[10:31:20.225] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[10:31:21.558] Starting the invocation (attempt 1)
[10:31:21.591] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:31:21.591] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:31:21.591] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9098761487824099664",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"71.0.3572.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:9098761487824099664",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[10:31:22.820] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1538908281684891",
    "id": "8933331425583385824",
    "lease_expiration_ts": "1539027082672742",
    "lease_key": "292202181",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"71.0.3572.0\"}}",
    "project": "infra",
    "result_details_json": "null",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1538908282687649",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9098761487824099664",
      "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:8933331425583385824",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
      "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/8933331425583385824/+/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:9098761487824099664",
      "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:7a2c6a280a68ea7a8c9976d934a89c38009336b9",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:user_agent:recipe",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4066e665fff4ad10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1538908282689767",
    "url": "https://ci.chromium.org/p/infra/builds/b8933331425583385824",
    "utcnow_ts": "1538908282808415"
  }
}
[10:31:22.820] Task URL: https://ci.chromium.org/p/infra/builds/b8933331425583385824
[10:31:22.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:2:0) after 1m0s
[10:32:12.198] Received PubSub notification, asking Buildbucket for the build status
[10:32:12.261] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:22.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:2:0)
[10:32:22.837] Timer tick, asking Buildbucket for the build status
[10:32:22.890] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:22.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:4:0) after 1m0s
[10:33:22.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:4:0)
[10:33:22.917] Timer tick, asking Buildbucket for the build status
[10:33:23.166] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:23.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:5:0) after 1m0s
[10:34:23.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:5:0)
[10:34:23.186] Timer tick, asking Buildbucket for the build status
[10:34:23.311] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:23.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:6:0) after 1m0s
[10:35:23.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:6:0)
[10:35:23.362] Timer tick, asking Buildbucket for the build status
[10:35:23.608] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:23.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:7:0) after 1m0s
[10:36:23.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:7:0)
[10:36:23.633] Timer tick, asking Buildbucket for the build status
[10:36:23.669] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:23.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:8:0) after 1m0s
[10:37:23.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:8:0)
[10:37:23.748] Timer tick, asking Buildbucket for the build status
[10:37:23.804] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:23.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:9:0) after 1m0s
[10:38:23.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:9:0)
[10:38:23.824] Timer tick, asking Buildbucket for the build status
[10:38:23.884] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:23.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:10:0) after 1m0s
[10:39:23.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:10:0)
[10:39:23.904] Timer tick, asking Buildbucket for the build status
[10:39:24.032] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:24.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:11:0) after 1m0s
[10:40:24.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:11:0)
[10:40:24.048] Timer tick, asking Buildbucket for the build status
[10:40:24.117] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:24.117] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:12:0) after 1m0s
[10:41:24.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:12:0)
[10:41:24.198] Timer tick, asking Buildbucket for the build status
[10:41:24.263] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:24.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:13:0) after 1m0s
[10:42:24.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:13:0)
[10:42:24.312] Timer tick, asking Buildbucket for the build status
[10:42:24.433] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:24.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:14:0) after 1m0s
[10:43:24.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:14:0)
[10:43:24.449] Timer tick, asking Buildbucket for the build status
[10:43:24.596] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:24.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:15:0) after 1m0s
[10:44:24.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:15:0)
[10:44:24.689] Timer tick, asking Buildbucket for the build status
[10:44:24.811] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:24.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:16:0) after 1m0s
[10:45:24.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:16:0)
[10:45:24.830] Timer tick, asking Buildbucket for the build status
[10:45:24.897] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:24.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:17:0) after 1m0s
[10:46:24.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:17:0)
[10:46:24.959] Timer tick, asking Buildbucket for the build status
[10:46:25.251] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:25.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:18:0) after 1m0s
[10:47:25.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:18:0)
[10:47:25.274] Timer tick, asking Buildbucket for the build status
[10:47:25.366] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:25.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:19:0) after 1m0s
[10:48:25.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:19:0)
[10:48:25.384] Timer tick, asking Buildbucket for the build status
[10:48:25.496] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:25.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:20:0) after 1m0s
[10:49:25.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:20:0)
[10:49:25.571] Timer tick, asking Buildbucket for the build status
[10:49:25.720] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:25.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:21:0) after 1m0s
[10:50:25.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:21:0)
[10:50:25.738] Timer tick, asking Buildbucket for the build status
[10:50:25.985] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:25.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:22:0) after 1m0s
[10:51:26.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:22:0)
[10:51:26.000] Timer tick, asking Buildbucket for the build status
[10:51:26.131] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:26.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:23:0) after 1m0s
[10:52:26.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:23:0)
[10:52:26.185] Timer tick, asking Buildbucket for the build status
[10:52:26.334] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:26.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:24:0) after 1m0s
[10:53:26.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:24:0)
[10:53:26.438] Timer tick, asking Buildbucket for the build status
[10:53:26.504] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:26.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:25:0) after 1m0s
[10:54:26.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:25:0)
[10:54:26.621] Timer tick, asking Buildbucket for the build status
[10:54:26.710] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:26.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:26:0) after 1m0s
[10:55:26.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:26:0)
[10:55:26.738] Timer tick, asking Buildbucket for the build status
[10:55:26.902] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:26.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:27:0) after 1m0s
[10:56:26.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:27:0)
[10:56:26.962] Timer tick, asking Buildbucket for the build status
[10:56:27.072] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:27.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:28:0) after 1m0s
[10:57:27.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:28:0)
[10:57:27.228] Timer tick, asking Buildbucket for the build status
[10:57:27.362] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:27.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:29:0) after 1m0s
[10:58:27.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:29:0)
[10:58:27.380] Timer tick, asking Buildbucket for the build status
[10:58:27.494] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:27.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:30:0) after 1m0s
[10:59:27.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:30:0)
[10:59:27.514] Timer tick, asking Buildbucket for the build status
[10:59:27.555] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:27.555] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:31:0) after 1m0s
[11:00:27.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:31:0)
[11:00:27.581] Timer tick, asking Buildbucket for the build status
[11:00:27.643] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:27.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:32:0) after 1m0s
[11:01:27.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:32:0)
[11:01:27.775] Timer tick, asking Buildbucket for the build status
[11:01:27.892] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:27.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:33:0) after 1m0s
[11:02:27.990] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:33:0)
[11:02:27.990] Timer tick, asking Buildbucket for the build status
[11:02:28.385] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:28.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:34:0) after 1m0s
[11:03:28.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:34:0)
[11:03:28.516] Timer tick, asking Buildbucket for the build status
[11:03:28.702] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:28.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:35:0) after 1m0s
[11:04:28.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:35:0)
[11:04:28.722] Timer tick, asking Buildbucket for the build status
[11:04:28.857] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:28.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:36:0) after 1m0s
[11:05:28.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:36:0)
[11:05:28.924] Timer tick, asking Buildbucket for the build status
[11:05:29.092] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:29.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:37:0) after 1m0s
[11:06:29.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:37:0)
[11:06:29.126] Timer tick, asking Buildbucket for the build status
[11:06:29.195] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:29.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:38:0) after 1m0s
[11:07:29.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:38:0)
[11:07:29.296] Timer tick, asking Buildbucket for the build status
[11:07:29.334] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:29.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:39:0) after 1m0s
[11:08:29.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:39:0)
[11:08:29.437] Timer tick, asking Buildbucket for the build status
[11:08:29.582] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:29.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:40:0) after 1m0s
[11:09:29.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:40:0)
[11:09:29.637] Timer tick, asking Buildbucket for the build status
[11:09:29.727] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:29.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:41:0) after 1m0s
[11:10:29.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:41:0)
[11:10:29.798] Timer tick, asking Buildbucket for the build status
[11:10:29.941] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:29.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:42:0) after 1m0s
[11:11:30.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:42:0)
[11:11:30.027] Timer tick, asking Buildbucket for the build status
[11:11:30.077] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:30.077] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:43:0) after 1m0s
[11:12:30.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:43:0)
[11:12:30.115] Timer tick, asking Buildbucket for the build status
[11:12:30.367] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:30.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:44:0) after 1m0s
[11:13:30.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:44:0)
[11:13:30.388] Timer tick, asking Buildbucket for the build status
[11:13:30.466] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:30.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:45:0) after 1m0s
[11:14:30.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:45:0)
[11:14:30.539] Timer tick, asking Buildbucket for the build status
[11:14:30.622] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:30.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:46:0) after 1m0s
[11:15:30.663] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:46:0)
[11:15:30.663] Timer tick, asking Buildbucket for the build status
[11:15:30.784] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:30.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:47:0) after 1m0s
[11:16:30.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:47:0)
[11:16:30.808] Timer tick, asking Buildbucket for the build status
[11:16:30.949] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:30.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:48:0) after 1m0s
[11:17:30.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:48:0)
[11:17:30.969] Timer tick, asking Buildbucket for the build status
[11:17:31.007] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:31.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:49:0) after 1m0s
[11:18:31.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:49:0)
[11:18:31.037] Timer tick, asking Buildbucket for the build status
[11:18:31.304] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:31.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:50:0) after 1m0s
[11:19:31.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:50:0)
[11:19:31.323] Timer tick, asking Buildbucket for the build status
[11:19:31.402] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:31.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:51:0) after 1m0s
[11:20:31.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:51:0)
[11:20:31.420] Timer tick, asking Buildbucket for the build status
[11:20:31.478] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:31.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:52:0) after 1m0s
[11:21:31.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:52:0)
[11:21:31.528] Timer tick, asking Buildbucket for the build status
[11:21:31.821] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:31.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:53:0) after 1m0s
[11:22:31.855] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:53:0)
[11:22:31.855] Timer tick, asking Buildbucket for the build status
[11:22:31.945] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:31.945] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:54:0) after 1m0s
[11:23:31.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:54:0)
[11:23:31.966] Timer tick, asking Buildbucket for the build status
[11:23:32.051] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:32.051] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:55:0) after 1m0s
[11:24:32.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:55:0)
[11:24:32.153] Timer tick, asking Buildbucket for the build status
[11:24:32.325] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:32.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:56:0) after 1m0s
[11:25:32.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:56:0)
[11:25:32.439] Timer tick, asking Buildbucket for the build status
[11:25:32.523] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:32.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:57:0) after 1m0s
[11:26:32.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:57:0)
[11:26:32.559] Timer tick, asking Buildbucket for the build status
[11:26:32.692] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:32.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:58:0) after 1m0s
[11:27:32.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:58:0)
[11:27:32.746] Timer tick, asking Buildbucket for the build status
[11:27:32.848] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:32.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:59:0) after 1m0s
[11:28:32.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:59:0)
[11:28:32.879] Timer tick, asking Buildbucket for the build status
[11:28:32.960] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:32.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:60:0) after 1m0s
[11:29:33.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:60:0)
[11:29:33.036] Timer tick, asking Buildbucket for the build status
[11:29:33.142] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:33.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:61:0) after 1m0s
[11:30:33.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:61:0)
[11:30:33.283] Timer tick, asking Buildbucket for the build status
[11:30:33.322] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:33.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:62:0) after 1m0s
[11:31:33.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:62:0)
[11:31:33.437] Timer tick, asking Buildbucket for the build status
[11:31:33.546] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:33.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:63:0) after 1m0s
[11:32:33.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:63:0)
[11:32:33.647] Timer tick, asking Buildbucket for the build status
[11:32:33.707] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:33.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:64:0) after 1m0s
[11:33:33.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:64:0)
[11:33:33.764] Timer tick, asking Buildbucket for the build status
[11:33:33.866] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:33.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:65:0) after 1m0s
[11:34:34.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:65:0)
[11:34:34.079] Timer tick, asking Buildbucket for the build status
[11:34:34.210] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:34.210] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:66:0) after 1m0s
[11:35:34.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:66:0)
[11:35:34.242] Timer tick, asking Buildbucket for the build status
[11:35:34.326] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:34.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:67:0) after 1m0s
[11:36:34.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:67:0)
[11:36:34.381] Timer tick, asking Buildbucket for the build status
[11:36:34.548] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:34.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:68:0) after 1m0s
[11:37:34.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:68:0)
[11:37:34.577] Timer tick, asking Buildbucket for the build status
[11:37:34.666] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:34.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:69:0) after 1m0s
[11:38:34.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:69:0)
[11:38:34.684] Timer tick, asking Buildbucket for the build status
[11:38:34.993] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:34.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:70:0) after 1m0s
[11:39:35.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:70:0)
[11:39:35.020] Timer tick, asking Buildbucket for the build status
[11:39:35.104] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:35.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:71:0) after 1m0s
[11:40:35.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:71:0)
[11:40:35.195] Timer tick, asking Buildbucket for the build status
[11:40:35.261] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:35.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:72:0) after 1m0s
[11:41:35.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:72:0)
[11:41:35.320] Timer tick, asking Buildbucket for the build status
[11:41:35.460] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:35.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:73:0) after 1m0s
[11:42:35.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:73:0)
[11:42:35.482] Timer tick, asking Buildbucket for the build status
[11:42:35.698] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:35.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:74:0) after 1m0s
[11:43:35.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:74:0)
[11:43:35.764] Timer tick, asking Buildbucket for the build status
[11:43:35.822] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:35.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:75:0) after 1m0s
[11:44:35.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:75:0)
[11:44:35.851] Timer tick, asking Buildbucket for the build status
[11:44:35.999] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:35.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:76:0) after 1m0s
[11:45:36.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:76:0)
[11:45:36.023] Timer tick, asking Buildbucket for the build status
[11:45:36.063] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:36.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:77:0) after 1m0s
[11:46:36.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:77:0)
[11:46:36.198] Timer tick, asking Buildbucket for the build status
[11:46:36.274] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:36.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:78:0) after 1m0s
[11:47:36.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:78:0)
[11:47:36.342] Timer tick, asking Buildbucket for the build status
[11:47:36.444] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:36.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:79:0) after 1m0s
[11:48:36.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:79:0)
[11:48:36.572] Timer tick, asking Buildbucket for the build status
[11:48:36.662] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:36.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:80:0) after 1m0s
[11:49:36.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:80:0)
[11:49:36.749] Timer tick, asking Buildbucket for the build status
[11:49:36.875] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:36.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:81:0) after 1m0s
[11:50:37.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:81:0)
[11:50:37.021] Timer tick, asking Buildbucket for the build status
[11:50:37.161] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:37.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:82:0) after 1m0s
[11:51:37.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:82:0)
[11:51:37.179] Timer tick, asking Buildbucket for the build status
[11:51:37.284] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:37.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:83:0) after 1m0s
[11:52:37.305] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:83:0)
[11:52:37.306] Timer tick, asking Buildbucket for the build status
[11:52:37.375] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:37.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:84:0) after 1m0s
[11:53:37.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:84:0)
[11:53:37.398] Timer tick, asking Buildbucket for the build status
[11:53:37.483] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:37.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:85:0) after 1m0s
[11:54:37.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:85:0)
[11:54:37.508] Timer tick, asking Buildbucket for the build status
[11:54:37.613] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:37.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:86:0) after 1m0s
[11:55:37.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:86:0)
[11:55:37.667] Timer tick, asking Buildbucket for the build status
[11:55:37.775] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:37.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:87:0) after 1m0s
[11:56:37.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:87:0)
[11:56:37.796] Timer tick, asking Buildbucket for the build status
[11:56:37.950] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:37.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:88:0) after 1m0s
[11:57:37.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:88:0)
[11:57:37.973] Timer tick, asking Buildbucket for the build status
[11:57:38.154] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:38.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:89:0) after 1m0s
[11:58:38.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:89:0)
[11:58:38.179] Timer tick, asking Buildbucket for the build status
[11:58:38.231] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:38.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:90:0) after 1m0s
[11:59:38.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:90:0)
[11:59:38.292] Timer tick, asking Buildbucket for the build status
[11:59:38.382] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:38.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:91:0) after 1m0s
[12:00:38.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:91:0)
[12:00:38.601] Timer tick, asking Buildbucket for the build status
[12:00:38.699] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:38.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:92:0) after 1m0s
[12:01:38.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:92:0)
[12:01:38.876] Timer tick, asking Buildbucket for the build status
[12:01:39.016] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:39.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:93:0) after 1m0s
[12:02:39.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:93:0)
[12:02:39.037] Timer tick, asking Buildbucket for the build status
[12:02:39.096] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:39.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:94:0) after 1m0s
[12:03:39.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:94:0)
[12:03:39.119] Timer tick, asking Buildbucket for the build status
[12:03:39.204] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:39.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:95:0) after 1m0s
[12:04:39.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:95:0)
[12:04:39.228] Timer tick, asking Buildbucket for the build status
[12:04:39.291] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:39.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:96:0) after 1m0s
[12:05:39.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:96:0)
[12:05:39.313] Timer tick, asking Buildbucket for the build status
[12:05:39.436] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:39.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:97:0) after 1m0s
[12:06:39.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:97:0)
[12:06:39.459] Timer tick, asking Buildbucket for the build status
[12:06:39.568] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:39.568] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:98:0) after 1m0s
[12:07:39.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:98:0)
[12:07:39.590] Timer tick, asking Buildbucket for the build status
[12:07:39.763] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:39.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:99:0) after 1m0s
[12:08:39.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:99:0)
[12:08:39.883] Timer tick, asking Buildbucket for the build status
[12:08:40.035] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:40.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:100:0) after 1m0s
[12:09:40.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:100:0)
[12:09:40.064] Timer tick, asking Buildbucket for the build status
[12:09:40.179] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:40.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:101:0) after 1m0s
[12:10:40.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:101:0)
[12:10:40.208] Timer tick, asking Buildbucket for the build status
[12:10:40.348] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:40.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:102:0) after 1m0s
[12:11:40.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:102:0)
[12:11:40.370] Timer tick, asking Buildbucket for the build status
[12:11:40.606] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:40.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:103:0) after 1m0s
[12:12:40.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:103:0)
[12:12:40.624] Timer tick, asking Buildbucket for the build status
[12:12:40.714] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:40.714] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:104:0) after 1m0s
[12:13:40.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:104:0)
[12:13:40.736] Timer tick, asking Buildbucket for the build status
[12:13:40.808] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:40.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:105:0) after 1m0s
[12:14:40.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:105:0)
[12:14:40.827] Timer tick, asking Buildbucket for the build status
[12:14:40.913] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:40.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:106:0) after 1m0s
[12:15:40.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:106:0)
[12:15:40.955] Timer tick, asking Buildbucket for the build status
[12:15:41.185] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:41.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:107:0) after 1m0s
[12:16:41.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:107:0)
[12:16:41.209] Timer tick, asking Buildbucket for the build status
[12:16:41.415] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:41.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:108:0) after 1m0s
[12:17:41.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:108:0)
[12:17:41.439] Timer tick, asking Buildbucket for the build status
[12:17:41.613] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:41.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:109:0) after 1m0s
[12:18:41.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:109:0)
[12:18:41.634] Timer tick, asking Buildbucket for the build status
[12:18:41.716] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:41.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:110:0) after 1m0s
[12:19:41.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:110:0)
[12:19:41.746] Timer tick, asking Buildbucket for the build status
[12:19:41.849] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:41.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:111:0) after 1m0s
[12:20:41.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:111:0)
[12:20:41.880] Timer tick, asking Buildbucket for the build status
[12:20:42.114] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:42.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:112:0) after 1m0s
[12:21:42.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:112:0)
[12:21:42.159] Timer tick, asking Buildbucket for the build status
[12:21:42.254] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:42.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:113:0) after 1m0s
[12:22:42.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:113:0)
[12:22:42.308] Timer tick, asking Buildbucket for the build status
[12:22:42.387] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:42.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:114:0) after 1m0s
[12:23:42.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:114:0)
[12:23:42.408] Timer tick, asking Buildbucket for the build status
[12:23:42.523] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:42.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:115:0) after 1m0s
[12:24:42.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:115:0)
[12:24:42.543] Timer tick, asking Buildbucket for the build status
[12:24:42.708] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:42.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:116:0) after 1m0s
[12:25:42.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:116:0)
[12:25:42.779] Timer tick, asking Buildbucket for the build status
[12:25:42.858] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:42.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:117:0) after 1m0s
[12:26:42.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:117:0)
[12:26:42.886] Timer tick, asking Buildbucket for the build status
[12:26:42.960] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:42.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:118:0) after 1m0s
[12:27:43.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:118:0)
[12:27:43.014] Timer tick, asking Buildbucket for the build status
[12:27:43.097] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:43.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:119:0) after 1m0s
[12:28:43.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:119:0)
[12:28:43.117] Timer tick, asking Buildbucket for the build status
[12:28:43.204] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:43.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:120:0) after 1m0s
[12:29:43.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:120:0)
[12:29:43.231] Timer tick, asking Buildbucket for the build status
[12:29:43.559] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:43.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:121:0) after 1m0s
[12:30:43.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:121:0)
[12:30:43.586] Timer tick, asking Buildbucket for the build status
[12:30:43.677] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:43.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:122:0) after 1m0s
[12:31:43.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:122:0)
[12:31:43.779] Timer tick, asking Buildbucket for the build status
[12:31:43.898] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:43.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:123:0) after 1m0s
[12:32:43.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:123:0)
[12:32:43.964] Timer tick, asking Buildbucket for the build status
[12:32:44.153] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:44.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:124:0) after 1m0s
[12:33:44.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:124:0)
[12:33:44.174] Timer tick, asking Buildbucket for the build status
[12:33:44.266] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:44.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:125:0) after 1m0s
[12:34:44.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:125:0)
[12:34:44.288] Timer tick, asking Buildbucket for the build status
[12:34:44.362] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:44.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:126:0) after 1m0s
[12:35:44.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:126:0)
[12:35:44.385] Timer tick, asking Buildbucket for the build status
[12:35:44.540] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:44.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:127:0) after 1m0s
[12:36:44.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:127:0)
[12:36:44.565] Timer tick, asking Buildbucket for the build status
[12:36:44.669] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:44.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:128:0) after 1m0s
[12:37:44.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:128:0)
[12:37:44.688] Timer tick, asking Buildbucket for the build status
[12:37:44.785] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:44.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:129:0) after 1m0s
[12:38:44.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:129:0)
[12:38:44.878] Timer tick, asking Buildbucket for the build status
[12:38:44.968] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:44.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:130:0) after 1m0s
[12:39:44.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:130:0)
[12:39:44.993] Timer tick, asking Buildbucket for the build status
[12:39:45.090] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:45.090] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:131:0) after 1m0s
[12:40:45.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:131:0)
[12:40:45.113] Timer tick, asking Buildbucket for the build status
[12:40:45.201] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:45.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:132:0) after 1m0s
[12:41:45.220] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:132:0)
[12:41:45.221] Timer tick, asking Buildbucket for the build status
[12:41:45.413] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:45.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:133:0) after 1m0s
[12:42:45.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:133:0)
[12:42:45.437] Timer tick, asking Buildbucket for the build status
[12:42:45.529] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:45.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:134:0) after 1m0s
[12:43:45.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:134:0)
[12:43:45.549] Timer tick, asking Buildbucket for the build status
[12:43:45.645] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:45.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:135:0) after 1m0s
[12:44:45.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:135:0)
[12:44:45.664] Timer tick, asking Buildbucket for the build status
[12:44:46.034] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:46.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:136:0) after 1m0s
[12:45:46.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:136:0)
[12:45:46.062] Timer tick, asking Buildbucket for the build status
[12:45:46.151] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:46.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:137:0) after 1m0s
[12:46:46.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:137:0)
[12:46:46.174] Timer tick, asking Buildbucket for the build status
[12:46:46.529] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:46.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:138:0) after 1m0s
[12:47:46.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:138:0)
[12:47:46.551] Timer tick, asking Buildbucket for the build status
[12:47:46.707] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:46.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:139:0) after 1m0s
[12:48:46.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:139:0)
[12:48:46.731] Timer tick, asking Buildbucket for the build status
[12:48:46.967] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:46.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:140:0) after 1m0s
[12:49:47.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:140:0)
[12:49:47.053] Timer tick, asking Buildbucket for the build status
[12:49:47.127] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:47.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:141:0) after 1m0s
[12:50:47.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:141:0)
[12:50:47.150] Timer tick, asking Buildbucket for the build status
[12:50:47.232] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:47.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:142:0) after 1m0s
[12:51:47.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:142:0)
[12:51:47.255] Timer tick, asking Buildbucket for the build status
[12:51:47.388] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:47.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:143:0) after 1m0s
[12:52:47.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:143:0)
[12:52:47.407] Timer tick, asking Buildbucket for the build status
[12:52:47.456] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:47.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:144:0) after 1m0s
[12:53:47.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:144:0)
[12:53:47.490] Timer tick, asking Buildbucket for the build status
[12:53:47.956] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:47.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:145:0) after 1m0s
[12:54:47.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:145:0)
[12:54:47.975] Timer tick, asking Buildbucket for the build status
[12:54:48.110] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:48.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:146:0) after 1m0s
[12:55:48.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:146:0)
[12:55:48.183] Timer tick, asking Buildbucket for the build status
[12:55:48.566] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:48.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:147:0) after 1m0s
[12:56:48.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:147:0)
[12:56:48.599] Timer tick, asking Buildbucket for the build status
[12:56:48.822] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:48.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:148:0) after 1m0s
[12:57:48.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:148:0)
[12:57:48.842] Timer tick, asking Buildbucket for the build status
[12:57:49.063] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:49.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:149:0) after 1m0s
[12:58:49.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:149:0)
[12:58:49.085] Timer tick, asking Buildbucket for the build status
[12:58:49.147] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:49.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:150:0) after 1m0s
[12:59:49.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:150:0)
[12:59:49.238] Timer tick, asking Buildbucket for the build status
[12:59:49.339] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:49.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:151:0) after 1m0s
[13:00:49.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:151:0)
[13:00:49.366] Timer tick, asking Buildbucket for the build status
[13:00:49.494] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:49.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:152:0) after 1m0s
[13:01:49.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:152:0)
[13:01:49.517] Timer tick, asking Buildbucket for the build status
[13:01:49.595] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:49.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:153:0) after 1m0s
[13:02:49.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:153:0)
[13:02:49.616] Timer tick, asking Buildbucket for the build status
[13:02:49.924] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:49.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:154:0) after 1m0s
[13:03:50.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:154:0)
[13:03:50.036] Timer tick, asking Buildbucket for the build status
[13:03:50.129] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:50.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:155:0) after 1m0s
[13:04:50.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:155:0)
[13:04:50.152] Timer tick, asking Buildbucket for the build status
[13:04:50.466] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:50.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:156:0) after 1m0s
[13:05:50.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:156:0)
[13:05:50.492] Timer tick, asking Buildbucket for the build status
[13:05:50.646] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:50.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:157:0) after 1m0s
[13:06:50.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:157:0)
[13:06:50.668] Timer tick, asking Buildbucket for the build status
[13:06:50.713] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:50.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:158:0) after 1m0s
[13:07:50.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:158:0)
[13:07:50.742] Timer tick, asking Buildbucket for the build status
[13:07:50.822] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:50.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:159:0) after 1m0s
[13:08:50.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:159:0)
[13:08:50.864] Timer tick, asking Buildbucket for the build status
[13:08:50.959] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:50.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:160:0) after 1m0s
[13:09:50.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:160:0)
[13:09:50.985] Timer tick, asking Buildbucket for the build status
[13:09:51.077] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:51.077] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:161:0) after 1m0s
[13:10:51.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:161:0)
[13:10:51.141] Timer tick, asking Buildbucket for the build status
[13:10:51.228] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:51.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:162:0) after 1m0s
[13:11:51.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:162:0)
[13:11:51.251] Timer tick, asking Buildbucket for the build status
[13:11:51.361] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:51.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:163:0) after 1m0s
[13:12:51.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:163:0)
[13:12:51.382] Timer tick, asking Buildbucket for the build status
[13:12:51.517] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:51.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:164:0) after 1m0s
[13:13:51.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:164:0)
[13:13:51.540] Timer tick, asking Buildbucket for the build status
[13:13:51.618] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:51.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:165:0) after 1m0s
[13:14:51.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:165:0)
[13:14:51.698] Timer tick, asking Buildbucket for the build status
[13:14:51.784] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:51.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:166:0) after 1m0s
[13:15:51.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:166:0)
[13:15:51.976] Timer tick, asking Buildbucket for the build status
[13:15:52.149] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:52.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:167:0) after 1m0s
[13:16:52.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:167:0)
[13:16:52.624] Timer tick, asking Buildbucket for the build status
[13:16:52.770] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:52.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:168:0) after 1m0s
[13:17:53.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:168:0)
[13:17:53.078] Timer tick, asking Buildbucket for the build status
[13:17:53.195] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:53.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:169:0) after 1m0s
[13:18:53.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:169:0)
[13:18:53.336] Timer tick, asking Buildbucket for the build status
[13:18:53.481] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:53.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:170:0) after 1m0s
[13:19:53.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:170:0)
[13:19:53.613] Timer tick, asking Buildbucket for the build status
[13:19:53.719] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:53.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:171:0) after 1m0s
[13:20:53.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:171:0)
[13:20:53.740] Timer tick, asking Buildbucket for the build status
[13:20:53.989] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:53.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:172:0) after 1m0s
[13:21:54.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:172:0)
[13:21:54.494] Timer tick, asking Buildbucket for the build status
[13:21:54.575] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:54.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:173:0) after 1m0s
[13:22:54.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:173:0)
[13:22:54.757] Timer tick, asking Buildbucket for the build status
[13:22:54.912] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:54.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:174:0) after 1m0s
[13:23:55.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:174:0)
[13:23:55.261] Timer tick, asking Buildbucket for the build status
[13:23:55.352] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:55.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:175:0) after 1m0s
[13:24:55.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:175:0)
[13:24:55.793] Timer tick, asking Buildbucket for the build status
[13:24:55.999] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:55.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:176:0) after 1m0s
[13:25:56.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:176:0)
[13:25:56.319] Timer tick, asking Buildbucket for the build status
[13:25:56.413] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:56.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:177:0) after 1m0s
[13:26:56.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:177:0)
[13:26:56.833] Timer tick, asking Buildbucket for the build status
[13:26:56.953] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:56.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:178:0) after 1m0s
[13:27:57.010] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:178:0)
[13:27:57.010] Timer tick, asking Buildbucket for the build status
[13:27:57.311] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:57.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:179:0) after 1m0s
[13:28:57.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:179:0)
[13:28:57.344] Timer tick, asking Buildbucket for the build status
[13:28:57.426] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:57.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:180:0) after 1m0s
[13:29:57.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:180:0)
[13:29:57.464] Timer tick, asking Buildbucket for the build status
[13:29:57.602] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:57.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:181:0) after 1m0s
[13:30:57.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:181:0)
[13:30:57.623] Timer tick, asking Buildbucket for the build status
[13:30:57.756] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:57.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:182:0) after 1m0s
[13:31:57.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:182:0)
[13:31:57.786] Timer tick, asking Buildbucket for the build status
[13:31:57.936] Build 8933331425583385824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:57.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9098761487824099664:183:0) after 1m0s
[13:32:36.258] Received PubSub notification, asking Buildbucket for the build status
[13:32:36.326] Build 8933331425583385824: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[13:32:36.326] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "completed_ts": "1538919155182769",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1538908281684891",
    "failure_reason": "INFRA_FAILURE",
    "id": "8933331425583385824",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"71.0.3572.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\": [\"3801-8761768\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-e833d7b0-us-east1-b-rqj4\"], \"pool\": [\"luci.infra.cron\"]}}, \"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1538908330828107",
    "status": "COMPLETED",
    "status_changed_ts": "1538919155711181",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9098761487824099664",
      "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:8933331425583385824",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
      "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/8933331425583385824/+/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:9098761487824099664",
      "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:7a2c6a280a68ea7a8c9976d934a89c38009336b9",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:user_agent:recipe",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4066e665fff4ad10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1538919155712319",
    "url": "https://ci.chromium.org/p/infra/builds/b8933331425583385824",
    "utcnow_ts": "1538919156288032"
  }
}
[13:32:36.326] Invocation finished in 3h1m16.162821718s with status FAILED