LUCI Scheduler :: infra :: Build From Tarball

Status: FAILED

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

Duration: 3 hours

Actions:

Definition (rev d0acf8648771c75c4d75c08daf9c0088a362343f)

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

Incoming triggers

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

Incoming properties

{
  "version": "72.0.3581.3"
}

Incoming tags

parent_buildername:publish_tarball
user_agent:recipe

Debug log (UTC)

[01:41:48.114] New invocation is queued and will start shortly
[01:41:48.114] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[01:41:49.409] Starting the invocation (attempt 1)
[01:41:49.465] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:41:49.465] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:41:49.465] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9097979430552930368",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"72.0.3581.3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9097979430552930368",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[01:41:50.848] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1539654109545466",
    "id": "8932549368387533856",
    "lease_expiration_ts": "1539772910621681",
    "lease_key": "1238375035",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"72.0.3581.3\"}}",
    "project": "infra",
    "result_details_json": "null",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1539654110632031",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9097979430552930368",
      "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:8932549368387533856",
      "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/8932549368387533856/+/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:9097979430552930368",
      "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:5e02f6736b5d25d7bb06d6ad547d0269e7eab96e",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:user_agent:recipe",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:40935ad3db96cb10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1539654110632143",
    "url": "https://ci.chromium.org/p/infra/builds/b8932549368387533856",
    "utcnow_ts": "1539654110825498"
  }
}
[01:41:50.848] Task URL: https://ci.chromium.org/p/infra/builds/b8932549368387533856
[01:41:50.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:2:0) after 1m0s
[01:42:48.931] Received PubSub notification, asking Buildbucket for the build status
[01:42:48.964] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:50.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:2:0)
[01:42:50.947] Timer tick, asking Buildbucket for the build status
[01:42:50.986] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:50.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:4:0) after 1m0s
[01:43:51.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:4:0)
[01:43:51.005] Timer tick, asking Buildbucket for the build status
[01:43:51.137] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:51.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:5:0) after 1m0s
[01:44:51.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:5:0)
[01:44:51.153] Timer tick, asking Buildbucket for the build status
[01:44:51.219] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:51.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:6:0) after 1m0s
[01:45:51.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:6:0)
[01:45:51.274] Timer tick, asking Buildbucket for the build status
[01:45:51.330] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:51.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:7:0) after 1m0s
[01:46:51.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:7:0)
[01:46:51.357] Timer tick, asking Buildbucket for the build status
[01:46:51.445] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:51.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:8:0) after 1m0s
[01:47:51.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:8:0)
[01:47:51.469] Timer tick, asking Buildbucket for the build status
[01:47:51.512] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:51.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:9:0) after 1m0s
[01:48:51.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:9:0)
[01:48:51.528] Timer tick, asking Buildbucket for the build status
[01:48:51.660] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:51.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:10:0) after 1m0s
[01:49:51.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:10:0)
[01:49:51.678] Timer tick, asking Buildbucket for the build status
[01:49:51.725] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:51.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:11:0) after 1m0s
[01:50:51.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:11:0)
[01:50:51.741] Timer tick, asking Buildbucket for the build status
[01:50:51.855] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:51.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:12:0) after 1m0s
[01:51:51.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:12:0)
[01:51:51.948] Timer tick, asking Buildbucket for the build status
[01:51:52.155] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:52.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:13:0) after 1m0s
[01:52:52.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:13:0)
[01:52:52.256] Timer tick, asking Buildbucket for the build status
[01:52:52.363] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:52.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:14:0) after 1m0s
[01:53:52.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:14:0)
[01:53:52.380] Timer tick, asking Buildbucket for the build status
[01:53:52.609] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:52.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:15:0) after 1m0s
[01:54:52.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:15:0)
[01:54:52.625] Timer tick, asking Buildbucket for the build status
[01:54:52.696] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:52.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:16:0) after 1m0s
[01:55:52.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:16:0)
[01:55:52.712] Timer tick, asking Buildbucket for the build status
[01:55:52.745] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:52.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:17:0) after 1m0s
[01:56:52.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:17:0)
[01:56:52.759] Timer tick, asking Buildbucket for the build status
[01:56:52.796] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:52.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:18:0) after 1m0s
[01:57:52.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:18:0)
[01:57:52.814] Timer tick, asking Buildbucket for the build status
[01:57:52.880] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:52.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:19:0) after 1m0s
[01:58:52.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:19:0)
[01:58:52.899] Timer tick, asking Buildbucket for the build status
[01:58:52.962] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:52.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:20:0) after 1m0s
[01:59:53.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:20:0)
[01:59:53.047] Timer tick, asking Buildbucket for the build status
[01:59:53.147] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:53.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:21:0) after 1m0s
[02:00:53.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:21:0)
[02:00:53.163] Timer tick, asking Buildbucket for the build status
[02:00:53.274] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:53.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:22:0) after 1m0s
[02:01:53.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:22:0)
[02:01:53.289] Timer tick, asking Buildbucket for the build status
[02:01:53.576] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:53.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:23:0) after 1m0s
[02:02:53.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:23:0)
[02:02:53.593] Timer tick, asking Buildbucket for the build status
[02:02:53.630] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:53.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:24:0) after 1m0s
[02:03:53.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:24:0)
[02:03:53.646] Timer tick, asking Buildbucket for the build status
[02:03:53.701] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:53.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:25:0) after 1m0s
[02:04:53.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:25:0)
[02:04:53.716] Timer tick, asking Buildbucket for the build status
[02:04:53.785] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:53.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:26:0) after 1m0s
[02:05:53.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:26:0)
[02:05:53.802] Timer tick, asking Buildbucket for the build status
[02:05:54.061] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:54.061] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:27:0) after 1m0s
[02:06:54.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:27:0)
[02:06:54.085] Timer tick, asking Buildbucket for the build status
[02:06:54.160] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:54.160] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:28:0) after 1m0s
[02:07:54.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:28:0)
[02:07:54.184] Timer tick, asking Buildbucket for the build status
[02:07:54.292] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:54.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:29:0) after 1m0s
[02:08:54.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:29:0)
[02:08:54.346] Timer tick, asking Buildbucket for the build status
[02:08:54.402] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:54.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:30:0) after 1m0s
[02:09:54.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:30:0)
[02:09:54.420] Timer tick, asking Buildbucket for the build status
[02:09:54.536] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:54.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:31:0) after 1m0s
[02:10:54.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:31:0)
[02:10:54.553] Timer tick, asking Buildbucket for the build status
[02:10:54.711] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:54.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:32:0) after 1m0s
[02:11:54.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:32:0)
[02:11:54.728] Timer tick, asking Buildbucket for the build status
[02:11:54.788] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:54.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:33:0) after 1m0s
[02:12:54.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:33:0)
[02:12:54.806] Timer tick, asking Buildbucket for the build status
[02:12:54.864] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:54.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:34:0) after 1m0s
[02:13:54.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:34:0)
[02:13:54.955] Timer tick, asking Buildbucket for the build status
[02:13:55.022] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:55.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:35:0) after 1m0s
[02:14:55.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:35:0)
[02:14:55.042] Timer tick, asking Buildbucket for the build status
[02:14:55.157] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:55.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:36:0) after 1m0s
[02:15:55.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:36:0)
[02:15:55.176] Timer tick, asking Buildbucket for the build status
[02:15:55.237] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:55.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:37:0) after 1m0s
[02:16:55.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:37:0)
[02:16:55.252] Timer tick, asking Buildbucket for the build status
[02:16:55.306] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:55.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:38:0) after 1m0s
[02:17:55.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:38:0)
[02:17:55.324] Timer tick, asking Buildbucket for the build status
[02:17:55.391] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:55.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:39:0) after 1m0s
[02:18:55.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:39:0)
[02:18:55.410] Timer tick, asking Buildbucket for the build status
[02:18:55.505] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:55.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:40:0) after 1m0s
[02:19:55.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:40:0)
[02:19:55.533] Timer tick, asking Buildbucket for the build status
[02:19:55.597] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:55.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:41:0) after 1m0s
[02:20:55.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:41:0)
[02:20:55.616] Timer tick, asking Buildbucket for the build status
[02:20:55.715] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:55.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:42:0) after 1m0s
[02:21:55.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:42:0)
[02:21:55.743] Timer tick, asking Buildbucket for the build status
[02:21:55.815] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:55.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:43:0) after 1m0s
[02:22:55.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:43:0)
[02:22:55.831] Timer tick, asking Buildbucket for the build status
[02:22:55.910] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:55.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:44:0) after 1m0s
[02:23:55.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:44:0)
[02:23:55.931] Timer tick, asking Buildbucket for the build status
[02:23:55.982] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:55.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:45:0) after 1m0s
[02:24:56.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:45:0)
[02:24:56.241] Timer tick, asking Buildbucket for the build status
[02:24:56.344] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:56.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:46:0) after 1m0s
[02:25:56.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:46:0)
[02:25:56.431] Timer tick, asking Buildbucket for the build status
[02:25:56.590] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:56.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:47:0) after 1m0s
[02:26:56.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:47:0)
[02:26:56.610] Timer tick, asking Buildbucket for the build status
[02:26:56.695] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:56.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:48:0) after 1m0s
[02:27:56.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:48:0)
[02:27:56.743] Timer tick, asking Buildbucket for the build status
[02:27:56.802] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:56.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:49:0) after 1m0s
[02:28:56.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:49:0)
[02:28:56.821] Timer tick, asking Buildbucket for the build status
[02:28:56.893] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:56.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:50:0) after 1m0s
[02:29:56.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:50:0)
[02:29:56.917] Timer tick, asking Buildbucket for the build status
[02:29:57.002] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:57.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:51:0) after 1m0s
[02:30:57.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:51:0)
[02:30:57.031] Timer tick, asking Buildbucket for the build status
[02:30:57.088] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:57.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:52:0) after 1m0s
[02:31:57.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:52:0)
[02:31:57.122] Timer tick, asking Buildbucket for the build status
[02:31:57.524] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:57.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:53:0) after 1m0s
[02:32:57.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:53:0)
[02:32:57.544] Timer tick, asking Buildbucket for the build status
[02:32:57.609] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:57.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:54:0) after 1m0s
[02:33:57.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:54:0)
[02:33:57.629] Timer tick, asking Buildbucket for the build status
[02:33:57.694] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:57.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:55:0) after 1m0s
[02:34:57.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:55:0)
[02:34:57.739] Timer tick, asking Buildbucket for the build status
[02:34:57.800] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:57.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:56:0) after 1m0s
[02:35:57.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:56:0)
[02:35:57.818] Timer tick, asking Buildbucket for the build status
[02:35:57.892] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:57.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:57:0) after 1m0s
[02:36:57.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:57:0)
[02:36:57.914] Timer tick, asking Buildbucket for the build status
[02:36:57.975] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:57.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:58:0) after 1m0s
[02:37:57.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:58:0)
[02:37:57.994] Timer tick, asking Buildbucket for the build status
[02:37:58.034] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:58.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:59:0) after 1m0s
[02:38:58.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:59:0)
[02:38:58.053] Timer tick, asking Buildbucket for the build status
[02:38:58.154] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:58.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:60:0) after 1m0s
[02:39:58.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:60:0)
[02:39:58.175] Timer tick, asking Buildbucket for the build status
[02:39:58.234] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:58.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:61:0) after 1m0s
[02:40:58.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:61:0)
[02:40:58.354] Timer tick, asking Buildbucket for the build status
[02:40:58.448] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:58.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:62:0) after 1m0s
[02:41:58.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:62:0)
[02:41:58.472] Timer tick, asking Buildbucket for the build status
[02:41:58.511] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:58.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:63:0) after 1m0s
[02:42:58.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:63:0)
[02:42:58.530] Timer tick, asking Buildbucket for the build status
[02:42:58.598] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:58.598] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:64:0) after 1m0s
[02:43:58.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:64:0)
[02:43:58.623] Timer tick, asking Buildbucket for the build status
[02:43:58.670] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:58.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:65:0) after 1m0s
[02:44:58.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:65:0)
[02:44:58.697] Timer tick, asking Buildbucket for the build status
[02:44:58.746] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:58.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:66:0) after 1m0s
[02:45:58.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:66:0)
[02:45:58.846] Timer tick, asking Buildbucket for the build status
[02:45:58.944] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:58.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:67:0) after 1m0s
[02:46:58.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:67:0)
[02:46:58.962] Timer tick, asking Buildbucket for the build status
[02:46:59.001] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:59.001] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:68:0) after 1m0s
[02:47:59.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:68:0)
[02:47:59.074] Timer tick, asking Buildbucket for the build status
[02:47:59.141] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:59.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:69:0) after 1m0s
[02:48:59.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:69:0)
[02:48:59.162] Timer tick, asking Buildbucket for the build status
[02:48:59.229] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:59.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:70:0) after 1m0s
[02:49:59.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:70:0)
[02:49:59.348] Timer tick, asking Buildbucket for the build status
[02:49:59.419] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:59.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:71:0) after 1m0s
[02:50:59.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:71:0)
[02:50:59.437] Timer tick, asking Buildbucket for the build status
[02:50:59.545] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:59.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:72:0) after 1m0s
[02:51:59.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:72:0)
[02:51:59.567] Timer tick, asking Buildbucket for the build status
[02:51:59.660] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:59.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:73:0) after 1m0s
[02:52:59.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:73:0)
[02:52:59.702] Timer tick, asking Buildbucket for the build status
[02:52:59.813] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:59.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:74:0) after 1m0s
[02:53:59.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:74:0)
[02:53:59.836] Timer tick, asking Buildbucket for the build status
[02:53:59.880] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:59.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:75:0) after 1m0s
[02:54:59.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:75:0)
[02:54:59.962] Timer tick, asking Buildbucket for the build status
[02:55:00.324] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:00.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:76:0) after 1m0s
[02:56:00.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:76:0)
[02:56:00.348] Timer tick, asking Buildbucket for the build status
[02:56:00.421] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:00.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:77:0) after 1m0s
[02:57:00.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:77:0)
[02:57:00.467] Timer tick, asking Buildbucket for the build status
[02:57:00.549] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:00.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:78:0) after 1m0s
[02:58:00.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:78:0)
[02:58:00.573] Timer tick, asking Buildbucket for the build status
[02:58:00.732] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:00.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:79:0) after 1m0s
[02:59:00.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:79:0)
[02:59:00.775] Timer tick, asking Buildbucket for the build status
[02:59:00.925] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:00.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:80:0) after 1m0s
[03:00:00.944] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:80:0)
[03:00:00.944] Timer tick, asking Buildbucket for the build status
[03:00:01.111] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:01.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:81:0) after 1m0s
[03:01:01.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:81:0)
[03:01:01.150] Timer tick, asking Buildbucket for the build status
[03:01:01.191] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:01.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:82:0) after 1m0s
[03:02:01.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:82:0)
[03:02:01.218] Timer tick, asking Buildbucket for the build status
[03:02:01.288] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:01.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:83:0) after 1m0s
[03:03:01.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:83:0)
[03:03:01.316] Timer tick, asking Buildbucket for the build status
[03:03:01.397] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:01.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:84:0) after 1m0s
[03:04:01.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:84:0)
[03:04:01.430] Timer tick, asking Buildbucket for the build status
[03:04:01.490] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:01.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:85:0) after 1m0s
[03:05:01.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:85:0)
[03:05:01.512] Timer tick, asking Buildbucket for the build status
[03:05:01.592] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:01.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:86:0) after 1m0s
[03:06:01.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:86:0)
[03:06:01.637] Timer tick, asking Buildbucket for the build status
[03:06:01.701] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:01.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:87:0) after 1m0s
[03:07:01.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:87:0)
[03:07:01.863] Timer tick, asking Buildbucket for the build status
[03:07:01.956] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:01.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:88:0) after 1m0s
[03:08:02.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:88:0)
[03:08:02.098] Timer tick, asking Buildbucket for the build status
[03:08:02.249] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:02.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:89:0) after 1m0s
[03:09:02.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:89:0)
[03:09:02.275] Timer tick, asking Buildbucket for the build status
[03:09:02.350] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:02.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:90:0) after 1m0s
[03:10:02.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:90:0)
[03:10:02.372] Timer tick, asking Buildbucket for the build status
[03:10:02.444] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:02.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:91:0) after 1m0s
[03:11:02.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:91:0)
[03:11:02.474] Timer tick, asking Buildbucket for the build status
[03:11:02.546] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:02.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:92:0) after 1m0s
[03:12:02.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:92:0)
[03:12:02.567] Timer tick, asking Buildbucket for the build status
[03:12:02.614] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:02.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:93:0) after 1m0s
[03:13:02.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:93:0)
[03:13:02.660] Timer tick, asking Buildbucket for the build status
[03:13:02.839] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:02.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:94:0) after 1m0s
[03:14:02.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:94:0)
[03:14:02.981] Timer tick, asking Buildbucket for the build status
[03:14:03.047] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:03.047] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:95:0) after 1m0s
[03:15:03.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:95:0)
[03:15:03.075] Timer tick, asking Buildbucket for the build status
[03:15:05.310] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:05.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:96:0) after 1m0s
[03:16:05.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:96:0)
[03:16:05.334] Timer tick, asking Buildbucket for the build status
[03:16:05.400] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:05.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:97:0) after 1m0s
[03:17:05.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:97:0)
[03:17:05.424] Timer tick, asking Buildbucket for the build status
[03:17:05.542] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:05.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:98:0) after 1m0s
[03:18:05.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:98:0)
[03:18:05.564] Timer tick, asking Buildbucket for the build status
[03:18:05.640] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:05.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:99:0) after 1m0s
[03:19:05.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:99:0)
[03:19:05.664] Timer tick, asking Buildbucket for the build status
[03:19:05.773] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:05.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:100:0) after 1m0s
[03:20:05.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:100:0)
[03:20:05.795] Timer tick, asking Buildbucket for the build status
[03:20:05.854] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:05.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:101:0) after 1m0s
[03:21:05.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:101:0)
[03:21:05.872] Timer tick, asking Buildbucket for the build status
[03:21:05.937] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:05.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:102:0) after 1m0s
[03:22:05.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:102:0)
[03:22:05.968] Timer tick, asking Buildbucket for the build status
[03:22:06.013] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:06.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:103:0) after 1m0s
[03:23:06.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:103:0)
[03:23:06.042] Timer tick, asking Buildbucket for the build status
[03:23:06.161] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:06.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:104:0) after 1m0s
[03:24:06.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:104:0)
[03:24:06.189] Timer tick, asking Buildbucket for the build status
[03:24:06.233] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:06.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:105:0) after 1m0s
[03:25:06.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:105:0)
[03:25:06.255] Timer tick, asking Buildbucket for the build status
[03:25:06.342] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:06.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:106:0) after 1m0s
[03:26:06.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:106:0)
[03:26:06.381] Timer tick, asking Buildbucket for the build status
[03:26:06.497] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:06.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:107:0) after 1m0s
[03:27:06.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:107:0)
[03:27:06.519] Timer tick, asking Buildbucket for the build status
[03:27:06.558] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:06.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:108:0) after 1m0s
[03:28:06.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:108:0)
[03:28:06.666] Timer tick, asking Buildbucket for the build status
[03:28:06.780] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:06.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:109:0) after 1m0s
[03:29:06.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:109:0)
[03:29:06.829] Timer tick, asking Buildbucket for the build status
[03:29:06.885] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:06.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:110:0) after 1m0s
[03:30:06.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:110:0)
[03:30:06.929] Timer tick, asking Buildbucket for the build status
[03:30:06.979] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:06.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:111:0) after 1m0s
[03:31:06.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:111:0)
[03:31:06.999] Timer tick, asking Buildbucket for the build status
[03:31:07.185] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:07.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:112:0) after 1m0s
[03:32:07.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:112:0)
[03:32:07.283] Timer tick, asking Buildbucket for the build status
[03:32:07.361] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:07.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:113:0) after 1m0s
[03:33:07.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:113:0)
[03:33:07.415] Timer tick, asking Buildbucket for the build status
[03:33:07.473] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:07.473] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:114:0) after 1m0s
[03:34:07.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:114:0)
[03:34:07.500] Timer tick, asking Buildbucket for the build status
[03:34:07.556] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:07.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:115:0) after 1m0s
[03:35:07.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:115:0)
[03:35:07.584] Timer tick, asking Buildbucket for the build status
[03:35:07.759] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:07.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:116:0) after 1m0s
[03:36:07.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:116:0)
[03:36:07.789] Timer tick, asking Buildbucket for the build status
[03:36:07.840] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:07.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:117:0) after 1m0s
[03:37:07.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:117:0)
[03:37:07.862] Timer tick, asking Buildbucket for the build status
[03:37:07.918] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:07.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:118:0) after 1m0s
[03:38:08.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:118:0)
[03:38:08.051] Timer tick, asking Buildbucket for the build status
[03:38:08.110] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:08.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:119:0) after 1m0s
[03:39:08.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:119:0)
[03:39:08.226] Timer tick, asking Buildbucket for the build status
[03:39:08.275] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:08.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:120:0) after 1m0s
[03:40:08.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:120:0)
[03:40:08.400] Timer tick, asking Buildbucket for the build status
[03:40:08.574] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:08.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:121:0) after 1m0s
[03:41:08.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:121:0)
[03:41:08.608] Timer tick, asking Buildbucket for the build status
[03:41:08.663] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:08.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:122:0) after 1m0s
[03:42:08.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:122:0)
[03:42:08.687] Timer tick, asking Buildbucket for the build status
[03:42:08.758] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:08.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:123:0) after 1m0s
[03:43:08.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:123:0)
[03:43:08.782] Timer tick, asking Buildbucket for the build status
[03:43:09.063] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:09.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:124:0) after 1m0s
[03:44:09.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:124:0)
[03:44:09.086] Timer tick, asking Buildbucket for the build status
[03:44:09.378] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:09.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:125:0) after 1m0s
[03:45:09.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:125:0)
[03:45:09.403] Timer tick, asking Buildbucket for the build status
[03:45:09.539] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:09.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:126:0) after 1m0s
[03:46:09.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:126:0)
[03:46:09.561] Timer tick, asking Buildbucket for the build status
[03:46:09.603] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:09.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:127:0) after 1m0s
[03:47:09.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:127:0)
[03:47:09.631] Timer tick, asking Buildbucket for the build status
[03:47:09.687] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:09.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:128:0) after 1m0s
[03:48:09.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:128:0)
[03:48:09.708] Timer tick, asking Buildbucket for the build status
[03:48:09.789] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:09.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:129:0) after 1m0s
[03:49:09.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:129:0)
[03:49:09.813] Timer tick, asking Buildbucket for the build status
[03:49:09.897] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:09.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:130:0) after 1m0s
[03:50:09.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:130:0)
[03:50:09.984] Timer tick, asking Buildbucket for the build status
[03:50:10.043] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:10.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:131:0) after 1m0s
[03:51:10.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:131:0)
[03:51:10.083] Timer tick, asking Buildbucket for the build status
[03:51:10.209] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:10.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:132:0) after 1m0s
[03:52:10.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:132:0)
[03:52:10.240] Timer tick, asking Buildbucket for the build status
[03:52:10.294] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:10.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:133:0) after 1m0s
[03:53:10.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:133:0)
[03:53:10.317] Timer tick, asking Buildbucket for the build status
[03:53:10.426] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:10.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:134:0) after 1m0s
[03:54:10.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:134:0)
[03:54:10.448] Timer tick, asking Buildbucket for the build status
[03:54:10.493] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:10.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:135:0) after 1m0s
[03:55:10.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:135:0)
[03:55:10.518] Timer tick, asking Buildbucket for the build status
[03:55:10.660] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:10.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:136:0) after 1m0s
[03:56:10.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:136:0)
[03:56:10.681] Timer tick, asking Buildbucket for the build status
[03:56:10.757] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:10.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:137:0) after 1m0s
[03:57:10.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:137:0)
[03:57:10.780] Timer tick, asking Buildbucket for the build status
[03:57:10.837] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:10.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:138:0) after 1m0s
[03:58:10.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:138:0)
[03:58:10.871] Timer tick, asking Buildbucket for the build status
[03:58:10.937] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:10.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:139:0) after 1m0s
[03:59:10.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:139:0)
[03:59:10.959] Timer tick, asking Buildbucket for the build status
[03:59:10.990] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:10.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:140:0) after 1m0s
[04:00:11.030] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:140:0)
[04:00:11.030] Timer tick, asking Buildbucket for the build status
[04:00:11.126] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:11.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:141:0) after 1m0s
[04:01:11.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:141:0)
[04:01:11.147] Timer tick, asking Buildbucket for the build status
[04:01:11.234] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:11.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:142:0) after 1m0s
[04:02:11.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:142:0)
[04:02:11.271] Timer tick, asking Buildbucket for the build status
[04:02:11.463] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:11.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:143:0) after 1m0s
[04:03:11.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:143:0)
[04:03:11.486] Timer tick, asking Buildbucket for the build status
[04:03:11.553] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:11.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:144:0) after 1m0s
[04:04:11.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:144:0)
[04:04:11.576] Timer tick, asking Buildbucket for the build status
[04:04:11.656] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:11.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:145:0) after 1m0s
[04:05:11.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:145:0)
[04:05:11.679] Timer tick, asking Buildbucket for the build status
[04:05:11.736] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:11.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:146:0) after 1m0s
[04:06:11.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:146:0)
[04:06:11.762] Timer tick, asking Buildbucket for the build status
[04:06:11.827] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:11.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:147:0) after 1m0s
[04:07:11.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:147:0)
[04:07:11.890] Timer tick, asking Buildbucket for the build status
[04:07:11.983] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:11.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:148:0) after 1m0s
[04:08:12.010] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:148:0)
[04:08:12.010] Timer tick, asking Buildbucket for the build status
[04:08:12.089] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:12.089] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:149:0) after 1m0s
[04:09:12.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:149:0)
[04:09:12.166] Timer tick, asking Buildbucket for the build status
[04:09:12.391] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:12.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:150:0) after 1m0s
[04:10:12.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:150:0)
[04:10:12.412] Timer tick, asking Buildbucket for the build status
[04:10:12.467] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:12.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:151:0) after 1m0s
[04:11:12.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:151:0)
[04:11:12.553] Timer tick, asking Buildbucket for the build status
[04:11:12.661] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:12.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:152:0) after 1m0s
[04:12:12.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:152:0)
[04:12:12.686] Timer tick, asking Buildbucket for the build status
[04:12:12.816] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:12.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:153:0) after 1m0s
[04:13:12.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:153:0)
[04:13:12.872] Timer tick, asking Buildbucket for the build status
[04:13:13.146] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:13.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:154:0) after 1m0s
[04:14:13.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:154:0)
[04:14:13.192] Timer tick, asking Buildbucket for the build status
[04:14:13.285] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:13.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:155:0) after 1m0s
[04:15:13.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:155:0)
[04:15:13.316] Timer tick, asking Buildbucket for the build status
[04:15:13.372] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:13.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:156:0) after 1m0s
[04:16:13.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:156:0)
[04:16:13.394] Timer tick, asking Buildbucket for the build status
[04:16:13.469] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:13.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:157:0) after 1m0s
[04:17:13.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:157:0)
[04:17:13.546] Timer tick, asking Buildbucket for the build status
[04:17:13.611] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:13.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:158:0) after 1m0s
[04:18:13.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:158:0)
[04:18:13.638] Timer tick, asking Buildbucket for the build status
[04:18:13.729] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:13.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:159:0) after 1m0s
[04:19:13.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:159:0)
[04:19:13.756] Timer tick, asking Buildbucket for the build status
[04:19:13.938] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:13.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:160:0) after 1m0s
[04:20:13.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:160:0)
[04:20:13.966] Timer tick, asking Buildbucket for the build status
[04:20:14.091] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:14.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:161:0) after 1m0s
[04:21:14.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:161:0)
[04:21:14.114] Timer tick, asking Buildbucket for the build status
[04:21:14.315] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:14.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:162:0) after 1m0s
[04:22:14.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:162:0)
[04:22:14.342] Timer tick, asking Buildbucket for the build status
[04:22:14.386] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:14.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:163:0) after 1m0s
[04:23:14.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:163:0)
[04:23:14.410] Timer tick, asking Buildbucket for the build status
[04:23:14.486] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:14.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:164:0) after 1m0s
[04:24:14.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:164:0)
[04:24:14.508] Timer tick, asking Buildbucket for the build status
[04:24:14.583] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:14.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:165:0) after 1m0s
[04:25:14.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:165:0)
[04:25:14.608] Timer tick, asking Buildbucket for the build status
[04:25:14.687] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:14.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:166:0) after 1m0s
[04:26:14.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:166:0)
[04:26:14.762] Timer tick, asking Buildbucket for the build status
[04:26:14.844] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:14.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:167:0) after 1m0s
[04:27:14.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:167:0)
[04:27:14.880] Timer tick, asking Buildbucket for the build status
[04:27:14.935] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:14.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:168:0) after 1m0s
[04:28:14.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:168:0)
[04:28:14.963] Timer tick, asking Buildbucket for the build status
[04:28:15.023] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:15.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:169:0) after 1m0s
[04:29:15.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:169:0)
[04:29:15.067] Timer tick, asking Buildbucket for the build status
[04:29:15.169] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:15.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:170:0) after 1m0s
[04:30:15.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:170:0)
[04:30:15.192] Timer tick, asking Buildbucket for the build status
[04:30:15.245] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:15.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:171:0) after 1m0s
[04:31:15.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:171:0)
[04:31:15.281] Timer tick, asking Buildbucket for the build status
[04:31:15.345] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:15.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:172:0) after 1m0s
[04:32:15.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:172:0)
[04:32:15.372] Timer tick, asking Buildbucket for the build status
[04:32:15.434] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:15.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:173:0) after 1m0s
[04:33:15.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:173:0)
[04:33:15.474] Timer tick, asking Buildbucket for the build status
[04:33:15.581] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:15.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:174:0) after 1m0s
[04:34:15.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:174:0)
[04:34:15.648] Timer tick, asking Buildbucket for the build status
[04:34:15.712] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:15.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:175:0) after 1m0s
[04:35:15.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:175:0)
[04:35:15.734] Timer tick, asking Buildbucket for the build status
[04:35:15.843] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:15.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:176:0) after 1m0s
[04:36:15.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:176:0)
[04:36:15.965] Timer tick, asking Buildbucket for the build status
[04:36:16.122] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:16.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:177:0) after 1m0s
[04:37:16.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:177:0)
[04:37:16.146] Timer tick, asking Buildbucket for the build status
[04:37:16.274] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:16.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:178:0) after 1m0s
[04:38:16.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:178:0)
[04:38:16.298] Timer tick, asking Buildbucket for the build status
[04:38:16.341] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:16.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:179:0) after 1m0s
[04:39:16.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:179:0)
[04:39:16.437] Timer tick, asking Buildbucket for the build status
[04:39:16.586] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:16.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:180:0) after 1m0s
[04:40:16.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:180:0)
[04:40:16.640] Timer tick, asking Buildbucket for the build status
[04:40:16.737] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:16.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:181:0) after 1m0s
[04:41:16.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:181:0)
[04:41:16.758] Timer tick, asking Buildbucket for the build status
[04:41:16.836] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:16.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:182:0) after 1m0s
[04:42:16.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:182:0)
[04:42:16.971] Timer tick, asking Buildbucket for the build status
[04:42:17.277] Build 8932549368387533856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:17.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9097979430552930368:183:0) after 1m0s
[04:43:14.028] Received PubSub notification, asking Buildbucket for the build status
[04:43:14.065] Build 8932549368387533856: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[04:43:14.065] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "completed_ts": "1539664992937389",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1539654109545466",
    "failure_reason": "INFRA_FAILURE",
    "id": "8932549368387533856",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"72.0.3581.3\"}}",
    "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-central\", \"us-central1\", \"us-central1-c\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-canary-e973df7c-us-central1-c-xkdd\"], \"pool\": [\"luci.infra.cron\"], \"caches\": [\"vpython\"]}}, \"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1539654168101603",
    "status": "COMPLETED",
    "status_changed_ts": "1539664993453395",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9097979430552930368",
      "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:8932549368387533856",
      "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/8932549368387533856/+/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:9097979430552930368",
      "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:5e02f6736b5d25d7bb06d6ad547d0269e7eab96e",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:user_agent:recipe",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:40935ad3db96cb10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1539664993458021",
    "url": "https://ci.chromium.org/p/infra/builds/b8932549368387533856",
    "utcnow_ts": "1539664994056196"
  }
}
[04:43:14.065] Invocation finished in 3h1m25.967702206s with status FAILED