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

Incoming tags

parent_buildername:publish_tarball
user_agent:recipe

Debug log (UTC)

[10:44:02.376] New invocation is queued and will start shortly
[10:44:02.376] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[10:44:03.886] Starting the invocation (attempt 1)
[10:44:03.921] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:44:03.921] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:44:03.921] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9096405167477538192",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"72.0.3599.0\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9096405167477538192",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[10:44:05.370] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1541155444032494",
    "id": "8930975105076588864",
    "lease_expiration_ts": "1541274245286173",
    "lease_key": "1327712076",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"72.0.3599.0\"}}",
    "project": "infra",
    "result_details_json": "null",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1541155445286834",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9096405167477538192",
      "scheduler_job_id:infra/Build From Tarball",
      "swarming_dimension:builder:Build From Tarball",
      "swarming_dimension:caches:builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_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:infra/cron",
      "swarming_tag:buildbucket_build_id:8930975105076588864",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:1",
      "swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
      "swarming_tag:builder:Build From Tarball",
      "swarming_tag:caches:builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8930975105076588864/+/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:9096405167477538192",
      "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:d8e4b421517c0797dba6d475690fb749489538cd",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:user_agent:recipe",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:40ecd760ad516310",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1541155445286891",
    "url": "https://ci.chromium.org/b/8930975105076588864",
    "utcnow_ts": "1541155445361646"
  }
}
[10:44:05.370] Task URL: https://ci.chromium.org/b/8930975105076588864
[10:44:05.370] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:2:0) after 1m0s
[10:44:53.218] Received PubSub notification, asking Buildbucket for the build status
[10:44:53.339] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:05.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:2:0)
[10:45:05.389] Timer tick, asking Buildbucket for the build status
[10:45:05.460] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:05.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:4:0) after 1m0s
[10:46:05.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:4:0)
[10:46:05.477] Timer tick, asking Buildbucket for the build status
[10:46:05.688] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:05.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:5:0) after 1m0s
[10:47:05.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:5:0)
[10:47:05.710] Timer tick, asking Buildbucket for the build status
[10:47:05.777] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:05.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:6:0) after 1m0s
[10:48:05.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:6:0)
[10:48:05.803] Timer tick, asking Buildbucket for the build status
[10:48:05.868] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:05.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:7:0) after 1m0s
[10:49:06.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:7:0)
[10:49:06.086] Timer tick, asking Buildbucket for the build status
[10:49:06.133] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:06.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:8:0) after 1m0s
[10:50:06.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:8:0)
[10:50:06.177] Timer tick, asking Buildbucket for the build status
[10:50:06.373] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:06.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:9:0) after 1m0s
[10:51:06.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:9:0)
[10:51:06.393] Timer tick, asking Buildbucket for the build status
[10:51:06.444] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:06.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:10:0) after 1m0s
[10:52:06.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:10:0)
[10:52:06.602] Timer tick, asking Buildbucket for the build status
[10:52:06.846] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:06.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:11:0) after 1m0s
[10:53:06.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:11:0)
[10:53:06.865] Timer tick, asking Buildbucket for the build status
[10:53:06.930] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:06.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:12:0) after 1m0s
[10:54:06.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:12:0)
[10:54:06.996] Timer tick, asking Buildbucket for the build status
[10:54:07.054] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:07.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:13:0) after 1m0s
[10:55:07.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:13:0)
[10:55:07.084] Timer tick, asking Buildbucket for the build status
[10:55:07.148] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:07.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:14:0) after 1m0s
[10:56:07.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:14:0)
[10:56:07.169] Timer tick, asking Buildbucket for the build status
[10:56:07.268] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:07.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:15:0) after 1m0s
[10:57:07.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:15:0)
[10:57:07.289] Timer tick, asking Buildbucket for the build status
[10:57:07.346] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:07.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:16:0) after 1m0s
[10:58:07.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:16:0)
[10:58:07.361] Timer tick, asking Buildbucket for the build status
[10:58:07.408] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:07.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:17:0) after 1m0s
[10:59:07.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:17:0)
[10:59:07.436] Timer tick, asking Buildbucket for the build status
[10:59:07.520] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:07.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:18:0) after 1m0s
[11:00:07.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:18:0)
[11:00:07.665] Timer tick, asking Buildbucket for the build status
[11:00:08.113] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:08.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:19:0) after 1m0s
[11:01:08.140] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:19:0)
[11:01:08.140] Timer tick, asking Buildbucket for the build status
[11:01:08.284] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:08.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:20:0) after 1m0s
[11:02:08.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:20:0)
[11:02:08.302] Timer tick, asking Buildbucket for the build status
[11:02:08.557] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:08.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:21:0) after 1m0s
[11:03:08.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:21:0)
[11:03:08.814] Timer tick, asking Buildbucket for the build status
[11:03:08.969] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:08.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:22:0) after 1m0s
[11:04:09.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:22:0)
[11:04:09.001] Timer tick, asking Buildbucket for the build status
[11:04:09.059] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:09.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:23:0) after 1m0s
[11:05:09.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:23:0)
[11:05:09.075] Timer tick, asking Buildbucket for the build status
[11:05:09.396] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:09.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:24:0) after 1m0s
[11:06:09.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:24:0)
[11:06:09.420] Timer tick, asking Buildbucket for the build status
[11:06:09.464] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:09.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:25:0) after 1m0s
[11:07:09.501] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:25:0)
[11:07:09.501] Timer tick, asking Buildbucket for the build status
[11:07:09.775] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:09.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:26:0) after 1m0s
[11:08:09.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:26:0)
[11:08:09.803] Timer tick, asking Buildbucket for the build status
[11:08:09.978] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:09.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:27:0) after 1m0s
[11:09:10.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:27:0)
[11:09:10.006] Timer tick, asking Buildbucket for the build status
[11:09:10.058] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:10.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:28:0) after 1m0s
[11:10:10.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:28:0)
[11:10:10.160] Timer tick, asking Buildbucket for the build status
[11:10:10.451] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:10.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:29:0) after 1m0s
[11:11:10.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:29:0)
[11:11:10.480] Timer tick, asking Buildbucket for the build status
[11:11:10.676] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:10.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:30:0) after 1m0s
[11:12:10.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:30:0)
[11:12:10.811] Timer tick, asking Buildbucket for the build status
[11:12:10.936] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:10.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:31:0) after 1m0s
[11:13:11.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:31:0)
[11:13:11.032] Timer tick, asking Buildbucket for the build status
[11:13:11.299] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:11.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:32:0) after 1m0s
[11:14:11.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:32:0)
[11:14:11.317] Timer tick, asking Buildbucket for the build status
[11:14:11.381] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:11.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:33:0) after 1m0s
[11:15:11.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:33:0)
[11:15:11.418] Timer tick, asking Buildbucket for the build status
[11:15:11.553] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:11.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:34:0) after 1m0s
[11:16:11.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:34:0)
[11:16:11.580] Timer tick, asking Buildbucket for the build status
[11:16:11.673] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:11.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:35:0) after 1m0s
[11:17:11.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:35:0)
[11:17:11.700] Timer tick, asking Buildbucket for the build status
[11:17:11.925] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:11.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:36:0) after 1m0s
[11:18:11.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:36:0)
[11:18:11.951] Timer tick, asking Buildbucket for the build status
[11:18:12.181] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:12.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:37:0) after 1m0s
[11:19:12.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:37:0)
[11:19:12.289] Timer tick, asking Buildbucket for the build status
[11:19:12.489] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:12.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:38:0) after 1m0s
[11:20:12.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:38:0)
[11:20:12.585] Timer tick, asking Buildbucket for the build status
[11:20:12.692] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:12.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:39:0) after 1m0s
[11:21:12.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:39:0)
[11:21:12.742] Timer tick, asking Buildbucket for the build status
[11:21:12.825] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:12.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:40:0) after 1m0s
[11:22:12.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:40:0)
[11:22:12.842] Timer tick, asking Buildbucket for the build status
[11:22:12.932] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:12.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:41:0) after 1m0s
[11:23:13.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:41:0)
[11:23:13.011] Timer tick, asking Buildbucket for the build status
[11:23:13.253] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:13.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:42:0) after 1m0s
[11:24:13.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:42:0)
[11:24:13.279] Timer tick, asking Buildbucket for the build status
[11:24:13.348] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:13.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:43:0) after 1m0s
[11:25:13.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:43:0)
[11:25:13.365] Timer tick, asking Buildbucket for the build status
[11:25:13.562] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:13.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:44:0) after 1m0s
[11:26:13.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:44:0)
[11:26:13.585] Timer tick, asking Buildbucket for the build status
[11:26:13.728] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:13.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:45:0) after 1m0s
[11:27:13.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:45:0)
[11:27:13.755] Timer tick, asking Buildbucket for the build status
[11:27:13.830] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:13.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:46:0) after 1m0s
[11:28:13.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:46:0)
[11:28:13.875] Timer tick, asking Buildbucket for the build status
[11:28:14.073] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:14.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:47:0) after 1m0s
[11:29:14.120] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:47:0)
[11:29:14.120] Timer tick, asking Buildbucket for the build status
[11:29:14.300] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:14.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:48:0) after 1m0s
[11:30:14.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:48:0)
[11:30:14.356] Timer tick, asking Buildbucket for the build status
[11:30:14.483] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:14.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:49:0) after 1m0s
[11:31:14.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:49:0)
[11:31:14.510] Timer tick, asking Buildbucket for the build status
[11:31:14.576] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:14.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:50:0) after 1m0s
[11:32:14.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:50:0)
[11:32:14.597] Timer tick, asking Buildbucket for the build status
[11:32:14.767] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:14.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:51:0) after 1m0s
[11:33:14.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:51:0)
[11:33:14.794] Timer tick, asking Buildbucket for the build status
[11:33:14.898] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:14.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:52:0) after 1m0s
[11:34:14.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:52:0)
[11:34:14.919] Timer tick, asking Buildbucket for the build status
[11:34:15.086] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:15.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:53:0) after 1m0s
[11:35:15.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:53:0)
[11:35:15.177] Timer tick, asking Buildbucket for the build status
[11:35:15.249] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:15.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:54:0) after 1m0s
[11:36:15.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:54:0)
[11:36:15.268] Timer tick, asking Buildbucket for the build status
[11:36:15.582] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:15.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:55:0) after 1m0s
[11:37:15.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:55:0)
[11:37:15.611] Timer tick, asking Buildbucket for the build status
[11:37:15.830] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:15.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:56:0) after 1m0s
[11:38:15.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:56:0)
[11:38:15.847] Timer tick, asking Buildbucket for the build status
[11:38:16.081] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:16.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:57:0) after 1m0s
[11:39:16.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:57:0)
[11:39:16.203] Timer tick, asking Buildbucket for the build status
[11:39:16.379] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:16.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:58:0) after 1m0s
[11:40:16.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:58:0)
[11:40:16.408] Timer tick, asking Buildbucket for the build status
[11:40:16.677] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:16.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:59:0) after 1m0s
[11:41:16.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:59:0)
[11:41:16.708] Timer tick, asking Buildbucket for the build status
[11:41:16.852] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:16.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:60:0) after 1m0s
[11:42:16.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:60:0)
[11:42:16.873] Timer tick, asking Buildbucket for the build status
[11:42:16.967] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:16.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:61:0) after 1m0s
[11:43:17.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:61:0)
[11:43:17.079] Timer tick, asking Buildbucket for the build status
[11:43:17.148] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:17.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:62:0) after 1m0s
[11:44:17.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:62:0)
[11:44:17.178] Timer tick, asking Buildbucket for the build status
[11:44:17.253] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:17.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:63:0) after 1m0s
[11:45:17.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:63:0)
[11:45:17.271] Timer tick, asking Buildbucket for the build status
[11:45:17.405] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:17.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:64:0) after 1m0s
[11:46:17.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:64:0)
[11:46:17.424] Timer tick, asking Buildbucket for the build status
[11:46:17.464] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:17.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:65:0) after 1m0s
[11:47:17.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:65:0)
[11:47:17.547] Timer tick, asking Buildbucket for the build status
[11:47:17.680] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:17.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:66:0) after 1m0s
[11:48:17.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:66:0)
[11:48:17.719] Timer tick, asking Buildbucket for the build status
[11:48:17.906] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:17.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:67:0) after 1m0s
[11:49:17.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:67:0)
[11:49:17.930] Timer tick, asking Buildbucket for the build status
[11:49:17.999] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:17.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:68:0) after 1m0s
[11:50:18.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:68:0)
[11:50:18.022] Timer tick, asking Buildbucket for the build status
[11:50:18.128] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:18.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:69:0) after 1m0s
[11:51:18.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:69:0)
[11:51:18.227] Timer tick, asking Buildbucket for the build status
[11:51:18.324] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:18.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:70:0) after 1m0s
[11:52:18.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:70:0)
[11:52:18.392] Timer tick, asking Buildbucket for the build status
[11:52:18.547] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:18.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:71:0) after 1m0s
[11:53:18.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:71:0)
[11:53:18.596] Timer tick, asking Buildbucket for the build status
[11:53:18.680] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:18.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:72:0) after 1m0s
[11:54:18.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:72:0)
[11:54:18.711] Timer tick, asking Buildbucket for the build status
[11:54:18.869] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:18.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:73:0) after 1m0s
[11:55:18.978] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:73:0)
[11:55:18.978] Timer tick, asking Buildbucket for the build status
[11:55:19.185] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:19.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:74:0) after 1m0s
[11:56:19.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:74:0)
[11:56:19.317] Timer tick, asking Buildbucket for the build status
[11:56:19.384] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:19.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:75:0) after 1m0s
[11:57:19.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:75:0)
[11:57:19.407] Timer tick, asking Buildbucket for the build status
[11:57:19.484] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:19.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:76:0) after 1m0s
[11:58:19.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:76:0)
[11:58:19.616] Timer tick, asking Buildbucket for the build status
[11:58:19.704] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:19.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:77:0) after 1m0s
[11:59:19.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:77:0)
[11:59:19.727] Timer tick, asking Buildbucket for the build status
[11:59:19.787] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:19.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:78:0) after 1m0s
[12:00:19.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:78:0)
[12:00:19.813] Timer tick, asking Buildbucket for the build status
[12:00:19.894] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:19.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:79:0) after 1m0s
[12:01:19.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:79:0)
[12:01:19.924] Timer tick, asking Buildbucket for the build status
[12:01:19.984] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:19.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:80:0) after 1m0s
[12:02:20.010] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:80:0)
[12:02:20.010] Timer tick, asking Buildbucket for the build status
[12:02:20.127] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:20.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:81:0) after 1m0s
[12:03:20.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:81:0)
[12:03:20.191] Timer tick, asking Buildbucket for the build status
[12:03:20.628] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:20.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:82:0) after 1m0s
[12:04:20.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:82:0)
[12:04:20.648] Timer tick, asking Buildbucket for the build status
[12:04:20.724] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:20.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:83:0) after 1m0s
[12:05:20.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:83:0)
[12:05:20.813] Timer tick, asking Buildbucket for the build status
[12:05:20.859] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:20.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:84:0) after 1m0s
[12:06:20.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:84:0)
[12:06:20.907] Timer tick, asking Buildbucket for the build status
[12:06:20.956] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:20.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:85:0) after 1m0s
[12:07:20.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:85:0)
[12:07:20.986] Timer tick, asking Buildbucket for the build status
[12:07:21.099] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:21.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:86:0) after 1m0s
[12:08:21.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:86:0)
[12:08:21.126] Timer tick, asking Buildbucket for the build status
[12:08:21.170] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:21.170] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:87:0) after 1m0s
[12:09:21.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:87:0)
[12:09:21.248] Timer tick, asking Buildbucket for the build status
[12:09:21.283] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:21.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:88:0) after 1m0s
[12:10:21.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:88:0)
[12:10:21.307] Timer tick, asking Buildbucket for the build status
[12:10:21.367] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:21.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:89:0) after 1m0s
[12:11:21.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:89:0)
[12:11:21.395] Timer tick, asking Buildbucket for the build status
[12:11:21.491] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:21.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:90:0) after 1m0s
[12:12:21.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:90:0)
[12:12:21.514] Timer tick, asking Buildbucket for the build status
[12:12:21.672] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:21.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:91:0) after 1m0s
[12:13:21.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:91:0)
[12:13:21.703] Timer tick, asking Buildbucket for the build status
[12:13:21.765] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:21.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:92:0) after 1m0s
[12:14:21.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:92:0)
[12:14:21.800] Timer tick, asking Buildbucket for the build status
[12:14:21.996] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:21.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:93:0) after 1m0s
[12:15:22.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:93:0)
[12:15:22.020] Timer tick, asking Buildbucket for the build status
[12:15:22.198] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:22.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:94:0) after 1m0s
[12:16:22.220] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:94:0)
[12:16:22.220] Timer tick, asking Buildbucket for the build status
[12:16:22.307] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:22.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:95:0) after 1m0s
[12:17:22.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:95:0)
[12:17:22.331] Timer tick, asking Buildbucket for the build status
[12:17:22.719] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:22.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:96:0) after 1m0s
[12:18:22.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:96:0)
[12:18:22.743] Timer tick, asking Buildbucket for the build status
[12:18:22.870] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:22.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:97:0) after 1m0s
[12:19:22.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:97:0)
[12:19:22.910] Timer tick, asking Buildbucket for the build status
[12:19:23.006] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:23.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:98:0) after 1m0s
[12:20:23.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:98:0)
[12:20:23.026] Timer tick, asking Buildbucket for the build status
[12:20:23.076] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:23.076] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:99:0) after 1m0s
[12:21:23.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:99:0)
[12:21:23.110] Timer tick, asking Buildbucket for the build status
[12:21:23.273] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:23.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:100:0) after 1m0s
[12:22:23.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:100:0)
[12:22:23.303] Timer tick, asking Buildbucket for the build status
[12:22:23.394] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:23.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:101:0) after 1m0s
[12:23:23.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:101:0)
[12:23:23.477] Timer tick, asking Buildbucket for the build status
[12:23:23.637] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:23.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:102:0) after 1m0s
[12:24:23.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:102:0)
[12:24:23.657] Timer tick, asking Buildbucket for the build status
[12:24:23.752] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:23.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:103:0) after 1m0s
[12:25:23.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:103:0)
[12:25:23.776] Timer tick, asking Buildbucket for the build status
[12:25:23.872] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:23.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:104:0) after 1m0s
[12:26:23.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:104:0)
[12:26:23.898] Timer tick, asking Buildbucket for the build status
[12:26:23.949] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:23.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:105:0) after 1m0s
[12:27:23.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:105:0)
[12:27:23.973] Timer tick, asking Buildbucket for the build status
[12:27:24.073] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:24.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:106:0) after 1m0s
[12:28:24.120] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:106:0)
[12:28:24.120] Timer tick, asking Buildbucket for the build status
[12:28:24.284] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:24.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:107:0) after 1m0s
[12:29:24.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:107:0)
[12:29:24.317] Timer tick, asking Buildbucket for the build status
[12:29:24.406] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:24.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:108:0) after 1m0s
[12:30:24.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:108:0)
[12:30:24.478] Timer tick, asking Buildbucket for the build status
[12:30:24.563] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:24.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:109:0) after 1m0s
[12:31:24.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:109:0)
[12:31:24.603] Timer tick, asking Buildbucket for the build status
[12:31:24.652] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:24.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:110:0) after 1m0s
[12:32:24.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:110:0)
[12:32:24.694] Timer tick, asking Buildbucket for the build status
[12:32:24.764] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:24.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:111:0) after 1m0s
[12:33:24.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:111:0)
[12:33:24.784] Timer tick, asking Buildbucket for the build status
[12:33:24.865] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:24.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:112:0) after 1m0s
[12:34:24.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:112:0)
[12:34:24.892] Timer tick, asking Buildbucket for the build status
[12:34:25.009] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:25.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:113:0) after 1m0s
[12:35:25.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:113:0)
[12:35:25.032] Timer tick, asking Buildbucket for the build status
[12:35:25.248] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:25.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:114:0) after 1m0s
[12:36:25.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:114:0)
[12:36:25.290] Timer tick, asking Buildbucket for the build status
[12:36:25.390] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:25.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:115:0) after 1m0s
[12:37:25.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:115:0)
[12:37:25.446] Timer tick, asking Buildbucket for the build status
[12:37:25.498] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:25.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:116:0) after 1m0s
[12:38:25.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:116:0)
[12:38:25.519] Timer tick, asking Buildbucket for the build status
[12:38:25.599] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:25.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:117:0) after 1m0s
[12:39:25.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:117:0)
[12:39:25.631] Timer tick, asking Buildbucket for the build status
[12:39:25.739] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:25.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:118:0) after 1m0s
[12:40:25.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:118:0)
[12:40:25.760] Timer tick, asking Buildbucket for the build status
[12:40:25.819] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:25.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:119:0) after 1m0s
[12:41:25.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:119:0)
[12:41:25.878] Timer tick, asking Buildbucket for the build status
[12:41:25.967] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:25.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:120:0) after 1m0s
[12:42:25.990] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:120:0)
[12:42:25.990] Timer tick, asking Buildbucket for the build status
[12:42:26.062] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:26.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:121:0) after 1m0s
[12:43:26.081] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:121:0)
[12:43:26.081] Timer tick, asking Buildbucket for the build status
[12:43:26.165] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:26.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:122:0) after 1m0s
[12:44:26.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:122:0)
[12:44:26.277] Timer tick, asking Buildbucket for the build status
[12:44:26.325] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:26.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:123:0) after 1m0s
[12:45:26.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:123:0)
[12:45:26.345] Timer tick, asking Buildbucket for the build status
[12:45:26.465] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:26.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:124:0) after 1m0s
[12:46:26.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:124:0)
[12:46:26.495] Timer tick, asking Buildbucket for the build status
[12:46:26.551] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:26.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:125:0) after 1m0s
[12:47:26.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:125:0)
[12:47:26.572] Timer tick, asking Buildbucket for the build status
[12:47:26.672] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:26.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:126:0) after 1m0s
[12:48:26.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:126:0)
[12:48:26.735] Timer tick, asking Buildbucket for the build status
[12:48:26.800] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:26.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:127:0) after 1m0s
[12:49:26.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:127:0)
[12:49:26.832] Timer tick, asking Buildbucket for the build status
[12:49:26.898] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:26.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:128:0) after 1m0s
[12:50:26.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:128:0)
[12:50:26.918] Timer tick, asking Buildbucket for the build status
[12:50:27.007] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:27.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:129:0) after 1m0s
[12:51:27.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:129:0)
[12:51:27.032] Timer tick, asking Buildbucket for the build status
[12:51:27.121] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:27.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:130:0) after 1m0s
[12:52:27.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:130:0)
[12:52:27.143] Timer tick, asking Buildbucket for the build status
[12:52:27.219] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:27.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:131:0) after 1m0s
[12:53:27.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:131:0)
[12:53:27.242] Timer tick, asking Buildbucket for the build status
[12:53:27.316] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:27.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:132:0) after 1m0s
[12:54:27.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:132:0)
[12:54:27.388] Timer tick, asking Buildbucket for the build status
[12:54:27.492] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:27.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:133:0) after 1m0s
[12:55:27.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:133:0)
[12:55:27.517] Timer tick, asking Buildbucket for the build status
[12:55:27.670] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:27.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:134:0) after 1m0s
[12:56:27.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:134:0)
[12:56:27.695] Timer tick, asking Buildbucket for the build status
[12:56:27.744] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:27.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:135:0) after 1m0s
[12:57:27.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:135:0)
[12:57:27.909] Timer tick, asking Buildbucket for the build status
[12:57:27.989] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:27.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:136:0) after 1m0s
[12:58:28.019] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:136:0)
[12:58:28.019] Timer tick, asking Buildbucket for the build status
[12:58:28.123] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:28.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:137:0) after 1m0s
[12:59:28.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:137:0)
[12:59:28.146] Timer tick, asking Buildbucket for the build status
[12:59:28.229] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:28.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:138:0) after 1m0s
[13:00:28.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:138:0)
[13:00:28.311] Timer tick, asking Buildbucket for the build status
[13:00:28.503] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:28.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:139:0) after 1m0s
[13:01:28.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:139:0)
[13:01:28.523] Timer tick, asking Buildbucket for the build status
[13:01:28.944] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:28.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:140:0) after 1m0s
[13:02:28.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:140:0)
[13:02:28.971] Timer tick, asking Buildbucket for the build status
[13:02:29.030] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:29.030] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:141:0) after 1m0s
[13:03:29.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:141:0)
[13:03:29.053] Timer tick, asking Buildbucket for the build status
[13:03:29.135] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:29.135] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:142:0) after 1m0s
[13:04:29.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:142:0)
[13:04:29.163] Timer tick, asking Buildbucket for the build status
[13:04:29.256] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:29.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:143:0) after 1m0s
[13:05:29.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:143:0)
[13:05:29.295] Timer tick, asking Buildbucket for the build status
[13:05:29.437] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:29.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:144:0) after 1m0s
[13:06:29.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:144:0)
[13:06:29.468] Timer tick, asking Buildbucket for the build status
[13:06:29.582] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:29.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:145:0) after 1m0s
[13:07:29.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:145:0)
[13:07:29.618] Timer tick, asking Buildbucket for the build status
[13:07:29.718] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:29.718] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:146:0) after 1m0s
[13:08:29.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:146:0)
[13:08:29.741] Timer tick, asking Buildbucket for the build status
[13:08:29.787] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:29.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:147:0) after 1m0s
[13:09:29.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:147:0)
[13:09:29.863] Timer tick, asking Buildbucket for the build status
[13:09:30.099] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:30.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:148:0) after 1m0s
[13:10:30.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:148:0)
[13:10:30.142] Timer tick, asking Buildbucket for the build status
[13:10:30.217] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:30.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:149:0) after 1m0s
[13:11:30.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:149:0)
[13:11:30.307] Timer tick, asking Buildbucket for the build status
[13:11:30.397] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:30.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:150:0) after 1m0s
[13:12:30.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:150:0)
[13:12:30.462] Timer tick, asking Buildbucket for the build status
[13:12:30.915] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:30.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:151:0) after 1m0s
[13:13:30.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:151:0)
[13:13:30.943] Timer tick, asking Buildbucket for the build status
[13:13:31.431] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:31.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:152:0) after 1m0s
[13:14:31.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:152:0)
[13:14:31.453] Timer tick, asking Buildbucket for the build status
[13:14:31.632] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:31.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:153:0) after 1m0s
[13:15:31.663] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:153:0)
[13:15:31.663] Timer tick, asking Buildbucket for the build status
[13:15:32.043] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:32.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:154:0) after 1m0s
[13:16:32.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:154:0)
[13:16:32.070] Timer tick, asking Buildbucket for the build status
[13:16:32.220] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:32.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:155:0) after 1m0s
[13:17:32.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:155:0)
[13:17:32.292] Timer tick, asking Buildbucket for the build status
[13:17:32.358] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:32.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:156:0) after 1m0s
[13:18:32.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:156:0)
[13:18:32.396] Timer tick, asking Buildbucket for the build status
[13:18:32.466] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:32.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:157:0) after 1m0s
[13:19:32.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:157:0)
[13:19:32.492] Timer tick, asking Buildbucket for the build status
[13:19:32.656] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:32.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:158:0) after 1m0s
[13:20:32.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:158:0)
[13:20:32.678] Timer tick, asking Buildbucket for the build status
[13:20:32.756] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:32.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:159:0) after 1m0s
[13:21:32.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:159:0)
[13:21:32.887] Timer tick, asking Buildbucket for the build status
[13:21:33.094] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:33.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:160:0) after 1m0s
[13:22:33.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:160:0)
[13:22:33.116] Timer tick, asking Buildbucket for the build status
[13:22:33.299] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:33.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:161:0) after 1m0s
[13:23:33.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:161:0)
[13:23:33.487] Timer tick, asking Buildbucket for the build status
[13:23:33.625] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:33.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:162:0) after 1m0s
[13:24:33.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:162:0)
[13:24:33.653] Timer tick, asking Buildbucket for the build status
[13:24:33.772] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:33.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:163:0) after 1m0s
[13:25:33.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:163:0)
[13:25:33.803] Timer tick, asking Buildbucket for the build status
[13:25:33.884] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:33.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:164:0) after 1m0s
[13:26:34.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:164:0)
[13:26:34.102] Timer tick, asking Buildbucket for the build status
[13:26:34.184] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:34.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:165:0) after 1m0s
[13:27:34.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:165:0)
[13:27:34.281] Timer tick, asking Buildbucket for the build status
[13:27:34.389] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:34.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:166:0) after 1m0s
[13:28:34.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:166:0)
[13:28:34.488] Timer tick, asking Buildbucket for the build status
[13:28:34.576] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:34.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:167:0) after 1m0s
[13:29:34.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:167:0)
[13:29:34.601] Timer tick, asking Buildbucket for the build status
[13:29:34.662] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:34.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:168:0) after 1m0s
[13:30:34.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:168:0)
[13:30:34.685] Timer tick, asking Buildbucket for the build status
[13:30:34.784] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:34.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:169:0) after 1m0s
[13:31:34.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:169:0)
[13:31:34.807] Timer tick, asking Buildbucket for the build status
[13:31:34.872] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:34.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:170:0) after 1m0s
[13:32:34.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:170:0)
[13:32:34.903] Timer tick, asking Buildbucket for the build status
[13:32:35.022] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:35.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:171:0) after 1m0s
[13:33:35.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:171:0)
[13:33:35.049] Timer tick, asking Buildbucket for the build status
[13:33:35.162] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:35.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:172:0) after 1m0s
[13:34:35.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:172:0)
[13:34:35.185] Timer tick, asking Buildbucket for the build status
[13:34:35.366] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:35.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:173:0) after 1m0s
[13:35:35.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:173:0)
[13:35:35.403] Timer tick, asking Buildbucket for the build status
[13:35:35.542] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:35.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:174:0) after 1m0s
[13:36:35.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:174:0)
[13:36:35.785] Timer tick, asking Buildbucket for the build status
[13:36:35.909] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:35.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:175:0) after 1m0s
[13:37:35.952] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:175:0)
[13:37:35.952] Timer tick, asking Buildbucket for the build status
[13:37:36.157] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:36.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:176:0) after 1m0s
[13:38:36.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:176:0)
[13:38:36.214] Timer tick, asking Buildbucket for the build status
[13:38:36.409] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:36.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:177:0) after 1m0s
[13:39:36.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:177:0)
[13:39:36.436] Timer tick, asking Buildbucket for the build status
[13:39:36.556] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:36.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:178:0) after 1m0s
[13:40:36.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:178:0)
[13:40:36.594] Timer tick, asking Buildbucket for the build status
[13:40:36.665] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:36.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:179:0) after 1m0s
[13:41:36.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:179:0)
[13:41:36.763] Timer tick, asking Buildbucket for the build status
[13:41:36.813] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:36.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:180:0) after 1m0s
[13:42:36.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:180:0)
[13:42:36.865] Timer tick, asking Buildbucket for the build status
[13:42:36.931] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:36.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:181:0) after 1m0s
[13:43:36.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:181:0)
[13:43:36.975] Timer tick, asking Buildbucket for the build status
[13:43:37.057] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:37.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:182:0) after 1m0s
[13:44:37.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:182:0)
[13:44:37.084] Timer tick, asking Buildbucket for the build status
[13:44:37.156] Build 8930975105076588864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:37.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096405167477538192:183:0) after 1m0s
[13:45:17.332] Received PubSub notification, asking Buildbucket for the build status
[13:45:17.380] Build 8930975105076588864: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[13:45:17.380] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "AUTO",
    "completed_ts": "1541166316289172",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1541155444032494",
    "failure_reason": "INFRA_FAILURE",
    "id": "8930975105076588864",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"72.0.3599.0\"}}",
    "project": "infra",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"\"}, \"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\": [\"3817-6aedaff\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-e833d7b0-us-east1-b-ptpw\"], \"pool\": [\"luci.infra.cron\"]}}, \"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1541155492361960",
    "status": "COMPLETED",
    "status_changed_ts": "1541166316849744",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9096405167477538192",
      "scheduler_job_id:infra/Build From Tarball",
      "swarming_dimension:builder:Build From Tarball",
      "swarming_dimension:caches:builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_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:infra/cron",
      "swarming_tag:buildbucket_build_id:8930975105076588864",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:1",
      "swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
      "swarming_tag:builder:Build From Tarball",
      "swarming_tag:caches:builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8930975105076588864/+/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:9096405167477538192",
      "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:d8e4b421517c0797dba6d475690fb749489538cd",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:user_agent:recipe",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:40ecd760ad516310",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1541166316851024",
    "url": "https://ci.chromium.org/b/8930975105076588864",
    "utcnow_ts": "1541166317363113"
  }
}
[13:45:17.380] Invocation finished in 3h1m15.020524595s with status FAILED