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

Incoming tags

  • parent_buildername:publish_tarball
  • user_agent:recipe

Debug log (UTC)

[02:50:40.266] New invocation is queued and will start shortly
[02:50:40.266] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[02:50:41.501] Starting the invocation (attempt 1)
[02:50:41.538] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:50:41.538] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:50:41.538] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9097703306777271216",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"70.0.3538.69\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9097703306777271216",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[02:50:43.032] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1539917441677818",
    "id": "8932273244633913312",
    "lease_expiration_ts": "1540036242873356",
    "lease_key": "1483381690",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"70.0.3538.69\"}}",
    "project": "infra",
    "result_details_json": "null",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1539917442874695",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9097703306777271216",
      "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:8932273244633913312",
      "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/8932273244633913312/+/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:9097703306777271216",
      "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:40a30cf5864af610",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1539917442874837",
    "url": "https://ci.chromium.org/p/infra/builds/b8932273244633913312",
    "utcnow_ts": "1539917443016342"
  }
}
[02:50:43.032] Task URL: https://ci.chromium.org/p/infra/builds/b8932273244633913312
[02:50:43.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:2:0) after 1m0s
[02:51:24.456] Received PubSub notification, asking Buildbucket for the build status
[02:51:24.490] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:43.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:2:0)
[02:51:43.049] Timer tick, asking Buildbucket for the build status
[02:51:43.087] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:43.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:4:0) after 1m0s
[02:52:43.121] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:4:0)
[02:52:43.121] Timer tick, asking Buildbucket for the build status
[02:52:43.183] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:43.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:5:0) after 1m0s
[02:53:43.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:5:0)
[02:53:43.258] Timer tick, asking Buildbucket for the build status
[02:53:43.300] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:43.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:6:0) after 1m0s
[02:54:43.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:6:0)
[02:54:43.314] Timer tick, asking Buildbucket for the build status
[02:54:43.365] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:43.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:7:0) after 1m0s
[02:55:43.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:7:0)
[02:55:43.384] Timer tick, asking Buildbucket for the build status
[02:55:43.436] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:43.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:8:0) after 1m0s
[02:56:43.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:8:0)
[02:56:43.457] Timer tick, asking Buildbucket for the build status
[02:56:43.544] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:43.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:9:0) after 1m0s
[02:57:43.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:9:0)
[02:57:43.604] Timer tick, asking Buildbucket for the build status
[02:57:43.692] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:43.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:10:0) after 1m0s
[02:58:43.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:10:0)
[02:58:43.728] Timer tick, asking Buildbucket for the build status
[02:58:43.819] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:43.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:11:0) after 1m0s
[02:59:43.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:11:0)
[02:59:43.862] Timer tick, asking Buildbucket for the build status
[02:59:43.922] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:43.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:12:0) after 1m0s
[03:00:43.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:12:0)
[03:00:43.967] Timer tick, asking Buildbucket for the build status
[03:00:44.190] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:44.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:13:0) after 1m0s
[03:01:44.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:13:0)
[03:01:44.214] Timer tick, asking Buildbucket for the build status
[03:01:44.306] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:44.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:14:0) after 1m0s
[03:02:44.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:14:0)
[03:02:44.355] Timer tick, asking Buildbucket for the build status
[03:02:44.456] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:44.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:15:0) after 1m0s
[03:03:44.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:15:0)
[03:03:44.477] Timer tick, asking Buildbucket for the build status
[03:03:44.562] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:44.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:16:0) after 1m0s
[03:04:44.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:16:0)
[03:04:44.578] Timer tick, asking Buildbucket for the build status
[03:04:44.651] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:44.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:17:0) after 1m0s
[03:05:44.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:17:0)
[03:05:44.670] Timer tick, asking Buildbucket for the build status
[03:05:44.723] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:44.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:18:0) after 1m0s
[03:06:44.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:18:0)
[03:06:44.766] Timer tick, asking Buildbucket for the build status
[03:06:44.910] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:44.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:19:0) after 1m0s
[03:07:44.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:19:0)
[03:07:44.928] Timer tick, asking Buildbucket for the build status
[03:07:45.144] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:45.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:20:0) after 1m0s
[03:08:45.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:20:0)
[03:08:45.176] Timer tick, asking Buildbucket for the build status
[03:08:45.492] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:45.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:21:0) after 1m0s
[03:09:45.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:21:0)
[03:09:45.512] Timer tick, asking Buildbucket for the build status
[03:09:45.625] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:45.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:22:0) after 1m0s
[03:10:45.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:22:0)
[03:10:45.644] Timer tick, asking Buildbucket for the build status
[03:10:45.742] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:45.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:23:0) after 1m0s
[03:11:45.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:23:0)
[03:11:45.762] Timer tick, asking Buildbucket for the build status
[03:11:45.999] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:45.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:24:0) after 1m0s
[03:12:46.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:24:0)
[03:12:46.018] Timer tick, asking Buildbucket for the build status
[03:12:46.133] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:46.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:25:0) after 1m0s
[03:13:46.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:25:0)
[03:13:46.174] Timer tick, asking Buildbucket for the build status
[03:13:46.325] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:46.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:26:0) after 1m0s
[03:14:46.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:26:0)
[03:14:46.342] Timer tick, asking Buildbucket for the build status
[03:14:46.521] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:46.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:27:0) after 1m0s
[03:15:46.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:27:0)
[03:15:46.540] Timer tick, asking Buildbucket for the build status
[03:15:46.581] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:46.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:28:0) after 1m0s
[03:16:46.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:28:0)
[03:16:46.631] Timer tick, asking Buildbucket for the build status
[03:16:46.809] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:46.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:29:0) after 1m0s
[03:17:46.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:29:0)
[03:17:46.837] Timer tick, asking Buildbucket for the build status
[03:17:46.922] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:46.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:30:0) after 1m0s
[03:18:46.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:30:0)
[03:18:46.940] Timer tick, asking Buildbucket for the build status
[03:18:46.986] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:46.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:31:0) after 1m0s
[03:19:47.010] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:31:0)
[03:19:47.010] Timer tick, asking Buildbucket for the build status
[03:19:47.079] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:47.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:32:0) after 1m0s
[03:20:47.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:32:0)
[03:20:47.104] Timer tick, asking Buildbucket for the build status
[03:20:47.305] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:47.305] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:33:0) after 1m0s
[03:21:47.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:33:0)
[03:21:47.356] Timer tick, asking Buildbucket for the build status
[03:21:47.479] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:47.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:34:0) after 1m0s
[03:22:47.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:34:0)
[03:22:47.498] Timer tick, asking Buildbucket for the build status
[03:22:47.556] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:47.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:35:0) after 1m0s
[03:23:47.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:35:0)
[03:23:47.585] Timer tick, asking Buildbucket for the build status
[03:23:47.665] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:47.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:36:0) after 1m0s
[03:24:47.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:36:0)
[03:24:47.689] Timer tick, asking Buildbucket for the build status
[03:24:47.764] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:47.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:37:0) after 1m0s
[03:25:47.844] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:37:0)
[03:25:47.844] Timer tick, asking Buildbucket for the build status
[03:25:47.910] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:47.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:38:0) after 1m0s
[03:26:47.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:38:0)
[03:26:47.953] Timer tick, asking Buildbucket for the build status
[03:26:48.042] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:48.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:39:0) after 1m0s
[03:27:48.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:39:0)
[03:27:48.064] Timer tick, asking Buildbucket for the build status
[03:27:48.137] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:48.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:40:0) after 1m0s
[03:28:48.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:40:0)
[03:28:48.172] Timer tick, asking Buildbucket for the build status
[03:28:48.311] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:48.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:41:0) after 1m0s
[03:29:48.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:41:0)
[03:29:48.342] Timer tick, asking Buildbucket for the build status
[03:29:48.430] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:48.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:42:0) after 1m0s
[03:30:48.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:42:0)
[03:30:48.454] Timer tick, asking Buildbucket for the build status
[03:30:48.527] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:48.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:43:0) after 1m0s
[03:31:48.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:43:0)
[03:31:48.552] Timer tick, asking Buildbucket for the build status
[03:31:48.698] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:48.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:44:0) after 1m0s
[03:32:48.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:44:0)
[03:32:48.727] Timer tick, asking Buildbucket for the build status
[03:32:48.782] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:48.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:45:0) after 1m0s
[03:33:48.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:45:0)
[03:33:48.801] Timer tick, asking Buildbucket for the build status
[03:33:48.910] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:48.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:46:0) after 1m0s
[03:34:48.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:46:0)
[03:34:48.931] Timer tick, asking Buildbucket for the build status
[03:34:49.014] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:49.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:47:0) after 1m0s
[03:35:49.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:47:0)
[03:35:49.037] Timer tick, asking Buildbucket for the build status
[03:35:49.113] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:49.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:48:0) after 1m0s
[03:36:49.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:48:0)
[03:36:49.267] Timer tick, asking Buildbucket for the build status
[03:36:49.533] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:49.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:49:0) after 1m0s
[03:37:49.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:49:0)
[03:37:49.569] Timer tick, asking Buildbucket for the build status
[03:37:49.826] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:49.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:50:0) after 1m0s
[03:38:49.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:50:0)
[03:38:49.845] Timer tick, asking Buildbucket for the build status
[03:38:50.155] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:50.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:51:0) after 1m0s
[03:39:50.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:51:0)
[03:39:50.187] Timer tick, asking Buildbucket for the build status
[03:39:50.256] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:50.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:52:0) after 1m0s
[03:40:50.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:52:0)
[03:40:50.285] Timer tick, asking Buildbucket for the build status
[03:40:50.473] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:50.473] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:53:0) after 1m0s
[03:41:50.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:53:0)
[03:41:50.502] Timer tick, asking Buildbucket for the build status
[03:41:50.618] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:50.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:54:0) after 1m0s
[03:42:50.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:54:0)
[03:42:50.657] Timer tick, asking Buildbucket for the build status
[03:42:50.739] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:50.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:55:0) after 1m0s
[03:43:50.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:55:0)
[03:43:50.785] Timer tick, asking Buildbucket for the build status
[03:43:51.159] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:51.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:56:0) after 1m0s
[03:44:51.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:56:0)
[03:44:51.257] Timer tick, asking Buildbucket for the build status
[03:44:51.327] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:51.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:57:0) after 1m0s
[03:45:51.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:57:0)
[03:45:51.354] Timer tick, asking Buildbucket for the build status
[03:45:51.411] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:51.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:58:0) after 1m0s
[03:46:51.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:58:0)
[03:46:51.442] Timer tick, asking Buildbucket for the build status
[03:46:51.524] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:51.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:59:0) after 1m0s
[03:47:51.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:59:0)
[03:47:51.667] Timer tick, asking Buildbucket for the build status
[03:47:52.009] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:52.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:60:0) after 1m0s
[03:48:52.030] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:60:0)
[03:48:52.030] Timer tick, asking Buildbucket for the build status
[03:48:52.099] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:52.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:61:0) after 1m0s
[03:49:52.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:61:0)
[03:49:52.123] Timer tick, asking Buildbucket for the build status
[03:49:52.317] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:52.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:62:0) after 1m0s
[03:50:52.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:62:0)
[03:50:52.343] Timer tick, asking Buildbucket for the build status
[03:50:52.437] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:52.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:63:0) after 1m0s
[03:51:52.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:63:0)
[03:51:52.563] Timer tick, asking Buildbucket for the build status
[03:51:52.686] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:52.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:64:0) after 1m0s
[03:52:52.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:64:0)
[03:52:52.711] Timer tick, asking Buildbucket for the build status
[03:52:52.808] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:52.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:65:0) after 1m0s
[03:53:52.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:65:0)
[03:53:52.837] Timer tick, asking Buildbucket for the build status
[03:53:52.960] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:52.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:66:0) after 1m0s
[03:54:53.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:66:0)
[03:54:53.042] Timer tick, asking Buildbucket for the build status
[03:54:53.096] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:53.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:67:0) after 1m0s
[03:55:53.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:67:0)
[03:55:53.145] Timer tick, asking Buildbucket for the build status
[03:55:53.230] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:53.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:68:0) after 1m0s
[03:56:53.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:68:0)
[03:56:53.250] Timer tick, asking Buildbucket for the build status
[03:56:53.324] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:53.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:69:0) after 1m0s
[03:57:53.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:69:0)
[03:57:53.349] Timer tick, asking Buildbucket for the build status
[03:57:53.527] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:53.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:70:0) after 1m0s
[03:58:53.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:70:0)
[03:58:53.554] Timer tick, asking Buildbucket for the build status
[03:58:53.695] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:53.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:71:0) after 1m0s
[03:59:53.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:71:0)
[03:59:53.727] Timer tick, asking Buildbucket for the build status
[03:59:53.800] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:53.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:72:0) after 1m0s
[04:00:53.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:72:0)
[04:00:53.892] Timer tick, asking Buildbucket for the build status
[04:00:53.964] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:53.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:73:0) after 1m0s
[04:01:53.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:73:0)
[04:01:53.983] Timer tick, asking Buildbucket for the build status
[04:01:54.064] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:54.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:74:0) after 1m0s
[04:02:54.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:74:0)
[04:02:54.085] Timer tick, asking Buildbucket for the build status
[04:02:54.223] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:54.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:75:0) after 1m0s
[04:03:54.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:75:0)
[04:03:54.245] Timer tick, asking Buildbucket for the build status
[04:03:54.317] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:54.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:76:0) after 1m0s
[04:04:54.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:76:0)
[04:04:54.340] Timer tick, asking Buildbucket for the build status
[04:04:54.420] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:54.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:77:0) after 1m0s
[04:05:54.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:77:0)
[04:05:54.452] Timer tick, asking Buildbucket for the build status
[04:05:54.550] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:54.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:78:0) after 1m0s
[04:06:54.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:78:0)
[04:06:54.588] Timer tick, asking Buildbucket for the build status
[04:06:54.666] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:54.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:79:0) after 1m0s
[04:07:54.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:79:0)
[04:07:54.698] Timer tick, asking Buildbucket for the build status
[04:07:54.750] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:54.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:80:0) after 1m0s
[04:08:54.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:80:0)
[04:08:54.770] Timer tick, asking Buildbucket for the build status
[04:08:54.857] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:54.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:81:0) after 1m0s
[04:09:54.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:81:0)
[04:09:54.881] Timer tick, asking Buildbucket for the build status
[04:09:55.003] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:55.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:82:0) after 1m0s
[04:10:55.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:82:0)
[04:10:55.034] Timer tick, asking Buildbucket for the build status
[04:10:55.093] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:55.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:83:0) after 1m0s
[04:11:55.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:83:0)
[04:11:55.135] Timer tick, asking Buildbucket for the build status
[04:11:55.291] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:55.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:84:0) after 1m0s
[04:12:55.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:84:0)
[04:12:55.312] Timer tick, asking Buildbucket for the build status
[04:12:55.621] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:55.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:85:0) after 1m0s
[04:13:55.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:85:0)
[04:13:55.639] Timer tick, asking Buildbucket for the build status
[04:13:55.707] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:55.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:86:0) after 1m0s
[04:14:55.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:86:0)
[04:14:55.726] Timer tick, asking Buildbucket for the build status
[04:14:55.891] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:55.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:87:0) after 1m0s
[04:15:55.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:87:0)
[04:15:55.920] Timer tick, asking Buildbucket for the build status
[04:15:56.245] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:56.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:88:0) after 1m0s
[04:16:56.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:88:0)
[04:16:56.335] Timer tick, asking Buildbucket for the build status
[04:16:56.415] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:56.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:89:0) after 1m0s
[04:17:56.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:89:0)
[04:17:56.481] Timer tick, asking Buildbucket for the build status
[04:17:56.538] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:56.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:90:0) after 1m0s
[04:18:56.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:90:0)
[04:18:56.595] Timer tick, asking Buildbucket for the build status
[04:18:56.697] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:56.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:91:0) after 1m0s
[04:19:56.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:91:0)
[04:19:56.742] Timer tick, asking Buildbucket for the build status
[04:19:57.095] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:57.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:92:0) after 1m0s
[04:20:57.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:92:0)
[04:20:57.127] Timer tick, asking Buildbucket for the build status
[04:20:57.237] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:57.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:93:0) after 1m0s
[04:21:57.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:93:0)
[04:21:57.259] Timer tick, asking Buildbucket for the build status
[04:21:57.308] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:57.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:94:0) after 1m0s
[04:22:57.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:94:0)
[04:22:57.333] Timer tick, asking Buildbucket for the build status
[04:22:57.487] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:57.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:95:0) after 1m0s
[04:23:57.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:95:0)
[04:23:57.512] Timer tick, asking Buildbucket for the build status
[04:23:57.613] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:57.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:96:0) after 1m0s
[04:24:57.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:96:0)
[04:24:57.640] Timer tick, asking Buildbucket for the build status
[04:24:57.968] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:57.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:97:0) after 1m0s
[04:25:57.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:97:0)
[04:25:57.996] Timer tick, asking Buildbucket for the build status
[04:25:58.102] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:58.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:98:0) after 1m0s
[04:26:58.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:98:0)
[04:26:58.125] Timer tick, asking Buildbucket for the build status
[04:26:58.463] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:58.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:99:0) after 1m0s
[04:27:58.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:99:0)
[04:27:58.493] Timer tick, asking Buildbucket for the build status
[04:27:58.562] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:58.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:100:0) after 1m0s
[04:28:58.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:100:0)
[04:28:58.582] Timer tick, asking Buildbucket for the build status
[04:28:58.657] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:58.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:101:0) after 1m0s
[04:29:58.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:101:0)
[04:29:58.755] Timer tick, asking Buildbucket for the build status
[04:29:58.823] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:58.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:102:0) after 1m0s
[04:30:58.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:102:0)
[04:30:58.861] Timer tick, asking Buildbucket for the build status
[04:30:58.941] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:58.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:103:0) after 1m0s
[04:31:59.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:103:0)
[04:31:59.006] Timer tick, asking Buildbucket for the build status
[04:31:59.044] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:59.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:104:0) after 1m0s
[04:32:59.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:104:0)
[04:32:59.065] Timer tick, asking Buildbucket for the build status
[04:32:59.107] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:59.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:105:0) after 1m0s
[04:33:59.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:105:0)
[04:33:59.129] Timer tick, asking Buildbucket for the build status
[04:33:59.252] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:59.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:106:0) after 1m0s
[04:34:59.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:106:0)
[04:34:59.273] Timer tick, asking Buildbucket for the build status
[04:34:59.363] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:59.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:107:0) after 1m0s
[04:35:59.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:107:0)
[04:35:59.428] Timer tick, asking Buildbucket for the build status
[04:35:59.608] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:59.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:108:0) after 1m0s
[04:36:59.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:108:0)
[04:36:59.631] Timer tick, asking Buildbucket for the build status
[04:36:59.716] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:59.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:109:0) after 1m0s
[04:37:59.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:109:0)
[04:37:59.765] Timer tick, asking Buildbucket for the build status
[04:37:59.894] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:59.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:110:0) after 1m0s
[04:38:59.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:110:0)
[04:38:59.925] Timer tick, asking Buildbucket for the build status
[04:38:59.978] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:59.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:111:0) after 1m0s
[04:40:00.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:111:0)
[04:40:00.007] Timer tick, asking Buildbucket for the build status
[04:40:00.253] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:00.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:112:0) after 1m0s
[04:41:00.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:112:0)
[04:41:00.275] Timer tick, asking Buildbucket for the build status
[04:41:00.336] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:00.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:113:0) after 1m0s
[04:42:00.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:113:0)
[04:42:00.411] Timer tick, asking Buildbucket for the build status
[04:42:00.553] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:00.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:114:0) after 1m0s
[04:43:00.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:114:0)
[04:43:00.575] Timer tick, asking Buildbucket for the build status
[04:43:00.680] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:00.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:115:0) after 1m0s
[04:44:00.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:115:0)
[04:44:00.712] Timer tick, asking Buildbucket for the build status
[04:44:00.812] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:00.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:116:0) after 1m0s
[04:45:00.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:116:0)
[04:45:00.846] Timer tick, asking Buildbucket for the build status
[04:45:00.965] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:00.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:117:0) after 1m0s
[04:46:00.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:117:0)
[04:46:00.995] Timer tick, asking Buildbucket for the build status
[04:46:01.073] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:01.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:118:0) after 1m0s
[04:47:01.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:118:0)
[04:47:01.093] Timer tick, asking Buildbucket for the build status
[04:47:01.188] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:01.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:119:0) after 1m0s
[04:48:01.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:119:0)
[04:48:01.213] Timer tick, asking Buildbucket for the build status
[04:48:01.268] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:01.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:120:0) after 1m0s
[04:49:01.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:120:0)
[04:49:01.301] Timer tick, asking Buildbucket for the build status
[04:49:01.463] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:01.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:121:0) after 1m0s
[04:50:01.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:121:0)
[04:50:01.513] Timer tick, asking Buildbucket for the build status
[04:50:01.630] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:01.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:122:0) after 1m0s
[04:51:01.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:122:0)
[04:51:01.656] Timer tick, asking Buildbucket for the build status
[04:51:01.743] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:01.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:123:0) after 1m0s
[04:52:01.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:123:0)
[04:52:01.771] Timer tick, asking Buildbucket for the build status
[04:52:01.862] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:01.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:124:0) after 1m0s
[04:53:01.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:124:0)
[04:53:01.911] Timer tick, asking Buildbucket for the build status
[04:53:02.074] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:02.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:125:0) after 1m0s
[04:54:02.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:125:0)
[04:54:02.097] Timer tick, asking Buildbucket for the build status
[04:54:02.192] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:02.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:126:0) after 1m0s
[04:55:02.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:126:0)
[04:55:02.473] Timer tick, asking Buildbucket for the build status
[04:55:02.559] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:02.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:127:0) after 1m0s
[04:56:02.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:127:0)
[04:56:02.600] Timer tick, asking Buildbucket for the build status
[04:56:02.771] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:02.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:128:0) after 1m0s
[04:57:02.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:128:0)
[04:57:02.865] Timer tick, asking Buildbucket for the build status
[04:57:03.114] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:03.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:129:0) after 1m0s
[04:58:03.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:129:0)
[04:58:03.152] Timer tick, asking Buildbucket for the build status
[04:58:03.371] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:03.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:130:0) after 1m0s
[04:59:03.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:130:0)
[04:59:03.445] Timer tick, asking Buildbucket for the build status
[04:59:05.474] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:05.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:131:0) after 1m0s
[05:00:05.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:131:0)
[05:00:05.627] Timer tick, asking Buildbucket for the build status
[05:00:05.763] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:05.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:132:0) after 1m0s
[05:01:05.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:132:0)
[05:01:05.800] Timer tick, asking Buildbucket for the build status
[05:01:05.870] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:05.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:133:0) after 1m0s
[05:02:05.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:133:0)
[05:02:05.893] Timer tick, asking Buildbucket for the build status
[05:02:05.997] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:05.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:134:0) after 1m0s
[05:03:06.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:134:0)
[05:03:06.018] Timer tick, asking Buildbucket for the build status
[05:03:06.170] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:06.170] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:135:0) after 1m0s
[05:04:06.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:135:0)
[05:04:06.202] Timer tick, asking Buildbucket for the build status
[05:04:06.269] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:06.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:136:0) after 1m0s
[05:05:06.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:136:0)
[05:05:06.426] Timer tick, asking Buildbucket for the build status
[05:05:06.531] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:06.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:137:0) after 1m0s
[05:06:06.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:137:0)
[05:06:06.550] Timer tick, asking Buildbucket for the build status
[05:06:06.697] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:06.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:138:0) after 1m0s
[05:07:06.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:138:0)
[05:07:06.722] Timer tick, asking Buildbucket for the build status
[05:07:06.898] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:06.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:139:0) after 1m0s
[05:08:06.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:139:0)
[05:08:06.922] Timer tick, asking Buildbucket for the build status
[05:08:07.002] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:07.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:140:0) after 1m0s
[05:09:07.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:140:0)
[05:09:07.063] Timer tick, asking Buildbucket for the build status
[05:09:07.195] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:07.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:141:0) after 1m0s
[05:10:07.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:141:0)
[05:10:07.274] Timer tick, asking Buildbucket for the build status
[05:10:07.387] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:07.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:142:0) after 1m0s
[05:11:07.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:142:0)
[05:11:07.424] Timer tick, asking Buildbucket for the build status
[05:11:07.505] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:07.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:143:0) after 1m0s
[05:12:07.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:143:0)
[05:12:07.532] Timer tick, asking Buildbucket for the build status
[05:12:07.616] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:07.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:144:0) after 1m0s
[05:13:07.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:144:0)
[05:13:07.642] Timer tick, asking Buildbucket for the build status
[05:13:07.731] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:07.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:145:0) after 1m0s
[05:14:07.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:145:0)
[05:14:07.843] Timer tick, asking Buildbucket for the build status
[05:14:07.982] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:07.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:146:0) after 1m0s
[05:15:08.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:146:0)
[05:15:08.005] Timer tick, asking Buildbucket for the build status
[05:15:08.116] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:08.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:147:0) after 1m0s
[05:16:08.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:147:0)
[05:16:08.138] Timer tick, asking Buildbucket for the build status
[05:16:08.203] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:08.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:148:0) after 1m0s
[05:17:08.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:148:0)
[05:17:08.278] Timer tick, asking Buildbucket for the build status
[05:17:08.352] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:08.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:149:0) after 1m0s
[05:18:08.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:149:0)
[05:18:08.489] Timer tick, asking Buildbucket for the build status
[05:18:08.580] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:08.580] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:150:0) after 1m0s
[05:19:08.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:150:0)
[05:19:08.736] Timer tick, asking Buildbucket for the build status
[05:19:08.814] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:08.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:151:0) after 1m0s
[05:20:08.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:151:0)
[05:20:08.835] Timer tick, asking Buildbucket for the build status
[05:20:09.083] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:09.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:152:0) after 1m0s
[05:21:09.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:152:0)
[05:21:09.149] Timer tick, asking Buildbucket for the build status
[05:21:09.442] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:09.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:153:0) after 1m0s
[05:22:09.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:153:0)
[05:22:09.480] Timer tick, asking Buildbucket for the build status
[05:22:09.543] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:09.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:154:0) after 1m0s
[05:23:09.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:154:0)
[05:23:09.566] Timer tick, asking Buildbucket for the build status
[05:23:09.655] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:09.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:155:0) after 1m0s
[05:24:09.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:155:0)
[05:24:09.678] Timer tick, asking Buildbucket for the build status
[05:24:09.758] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:09.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:156:0) after 1m0s
[05:25:09.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:156:0)
[05:25:09.779] Timer tick, asking Buildbucket for the build status
[05:25:09.816] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:09.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:157:0) after 1m0s
[05:26:09.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:157:0)
[05:26:09.913] Timer tick, asking Buildbucket for the build status
[05:26:09.993] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:09.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:158:0) after 1m0s
[05:27:10.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:158:0)
[05:27:10.052] Timer tick, asking Buildbucket for the build status
[05:27:10.106] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:10.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:159:0) after 1m0s
[05:28:10.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:159:0)
[05:28:10.217] Timer tick, asking Buildbucket for the build status
[05:28:10.327] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:10.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:160:0) after 1m0s
[05:29:10.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:160:0)
[05:29:10.358] Timer tick, asking Buildbucket for the build status
[05:29:10.423] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:10.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:161:0) after 1m0s
[05:30:10.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:161:0)
[05:30:10.448] Timer tick, asking Buildbucket for the build status
[05:30:10.504] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:10.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:162:0) after 1m0s
[05:31:10.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:162:0)
[05:31:10.538] Timer tick, asking Buildbucket for the build status
[05:31:10.624] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:10.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:163:0) after 1m0s
[05:32:10.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:163:0)
[05:32:10.645] Timer tick, asking Buildbucket for the build status
[05:32:10.728] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:10.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:164:0) after 1m0s
[05:33:10.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:164:0)
[05:33:10.751] Timer tick, asking Buildbucket for the build status
[05:33:11.005] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:11.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:165:0) after 1m0s
[05:34:11.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:165:0)
[05:34:11.028] Timer tick, asking Buildbucket for the build status
[05:34:11.143] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:11.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:166:0) after 1m0s
[05:35:11.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:166:0)
[05:35:11.244] Timer tick, asking Buildbucket for the build status
[05:35:11.342] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:11.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:167:0) after 1m0s
[05:36:11.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:167:0)
[05:36:11.363] Timer tick, asking Buildbucket for the build status
[05:36:11.443] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:11.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:168:0) after 1m0s
[05:37:11.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:168:0)
[05:37:11.486] Timer tick, asking Buildbucket for the build status
[05:37:11.740] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:11.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:169:0) after 1m0s
[05:38:11.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:169:0)
[05:38:11.761] Timer tick, asking Buildbucket for the build status
[05:38:11.832] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:11.832] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:170:0) after 1m0s
[05:39:11.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:170:0)
[05:39:11.873] Timer tick, asking Buildbucket for the build status
[05:39:11.944] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:11.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:171:0) after 1m0s
[05:40:11.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:171:0)
[05:40:11.992] Timer tick, asking Buildbucket for the build status
[05:40:12.049] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:12.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:172:0) after 1m0s
[05:41:12.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:172:0)
[05:41:12.074] Timer tick, asking Buildbucket for the build status
[05:41:12.189] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:12.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:173:0) after 1m0s
[05:42:12.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:173:0)
[05:42:12.211] Timer tick, asking Buildbucket for the build status
[05:42:12.277] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:12.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:174:0) after 1m0s
[05:43:12.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:174:0)
[05:43:12.298] Timer tick, asking Buildbucket for the build status
[05:43:12.353] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:12.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:175:0) after 1m0s
[05:44:12.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:175:0)
[05:44:12.377] Timer tick, asking Buildbucket for the build status
[05:44:12.411] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:12.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:176:0) after 1m0s
[05:45:12.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:176:0)
[05:45:12.431] Timer tick, asking Buildbucket for the build status
[05:45:12.538] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:12.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:177:0) after 1m0s
[05:46:12.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:177:0)
[05:46:12.573] Timer tick, asking Buildbucket for the build status
[05:46:12.651] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:12.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:178:0) after 1m0s
[05:47:12.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:178:0)
[05:47:12.679] Timer tick, asking Buildbucket for the build status
[05:47:12.724] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:12.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:179:0) after 1m0s
[05:48:12.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:179:0)
[05:48:12.750] Timer tick, asking Buildbucket for the build status
[05:48:12.929] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:12.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:180:0) after 1m0s
[05:49:12.990] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:180:0)
[05:49:12.990] Timer tick, asking Buildbucket for the build status
[05:49:13.048] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:13.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:181:0) after 1m0s
[05:50:13.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:181:0)
[05:50:13.071] Timer tick, asking Buildbucket for the build status
[05:50:13.133] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:13.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:182:0) after 1m0s
[05:51:13.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:182:0)
[05:51:13.156] Timer tick, asking Buildbucket for the build status
[05:51:13.309] Build 8932273244633913312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:13.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097703306777271216:183:0) after 1m0s
[05:51:56.027] Received PubSub notification, asking Buildbucket for the build status
[05:51:56.056] Build 8932273244633913312: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[05:51:56.056] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "completed_ts": "1539928314815448",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1539917441677818",
    "failure_reason": "INFRA_FAILURE",
    "id": "8932273244633913312",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"70.0.3538.69\"}}",
    "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-2t33\"], \"pool\": [\"luci.infra.cron\"], \"caches\": [\"vpython\"]}}, \"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1539917483748569",
    "status": "COMPLETED",
    "status_changed_ts": "1539928315158323",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9097703306777271216",
      "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:8932273244633913312",
      "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/8932273244633913312/+/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:9097703306777271216",
      "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:40a30cf5864af610",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1539928315159303",
    "url": "https://ci.chromium.org/p/infra/builds/b8932273244633913312",
    "utcnow_ts": "1539928316047428"
  }
}
[05:51:56.056] Invocation finished in 3h1m15.806487958s with status FAILED