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

Incoming tags

  • parent_buildername:publish_tarball
  • user_agent:recipe

Debug log (UTC)

[09:47:08.248] New invocation is queued and will start shortly
[09:47:08.248] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[09:47:09.475] Starting the invocation (attempt 1)
[09:47:09.511] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:47:09.511] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:47:09.511] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9096318150485091568",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"72.0.3600.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:9096318150485091568",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[09:47:10.921] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1541238429636766",
    "id": "8930888088364237168",
    "lease_expiration_ts": "1541357230539598",
    "lease_key": "487764145",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"72.0.3600.0\"}}",
    "project": "infra",
    "result_details_json": "null",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1541238430540574",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9096318150485091568",
      "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:8930888088364237168",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
      "swarming_tag:builder:Build From Tarball",
      "swarming_tag:caches:builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8930888088364237168/+/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:9096318150485091568",
      "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:ec92cebceb578036635bdb39ec91102625e5b767",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:user_agent:recipe",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:40f1c9a16dfb7d10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1541238430540672",
    "url": "https://ci.chromium.org/b/8930888088364237168",
    "utcnow_ts": "1541238430911253"
  }
}
[09:47:10.921] Task URL: https://ci.chromium.org/b/8930888088364237168
[09:47:10.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:2:0) after 1m0s
[09:48:06.233] Received PubSub notification, asking Buildbucket for the build status
[09:48:06.326] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:10.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:2:0)
[09:48:10.942] Timer tick, asking Buildbucket for the build status
[09:48:11.016] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:11.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:4:0) after 1m0s
[09:49:11.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:4:0)
[09:49:11.033] Timer tick, asking Buildbucket for the build status
[09:49:11.078] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:11.078] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:5:0) after 1m0s
[09:50:11.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:5:0)
[09:50:11.099] Timer tick, asking Buildbucket for the build status
[09:50:11.153] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:11.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:6:0) after 1m0s
[09:51:11.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:6:0)
[09:51:11.177] Timer tick, asking Buildbucket for the build status
[09:51:11.272] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:11.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:7:0) after 1m0s
[09:52:11.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:7:0)
[09:52:11.290] Timer tick, asking Buildbucket for the build status
[09:52:11.353] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:11.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:8:0) after 1m0s
[09:53:11.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:8:0)
[09:53:11.374] Timer tick, asking Buildbucket for the build status
[09:53:11.432] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:11.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:9:0) after 1m0s
[09:54:11.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:9:0)
[09:54:11.449] Timer tick, asking Buildbucket for the build status
[09:54:11.527] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:11.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:10:0) after 1m0s
[09:55:11.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:10:0)
[09:55:11.545] Timer tick, asking Buildbucket for the build status
[09:55:11.720] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:11.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:11:0) after 1m0s
[09:56:11.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:11:0)
[09:56:11.740] Timer tick, asking Buildbucket for the build status
[09:56:11.797] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:11.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:12:0) after 1m0s
[09:57:11.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:12:0)
[09:57:11.821] Timer tick, asking Buildbucket for the build status
[09:57:11.889] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:11.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:13:0) after 1m0s
[09:58:11.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:13:0)
[09:58:11.912] Timer tick, asking Buildbucket for the build status
[09:58:11.994] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:11.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:14:0) after 1m0s
[09:59:12.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:14:0)
[09:59:12.013] Timer tick, asking Buildbucket for the build status
[09:59:12.068] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:12.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:15:0) after 1m0s
[10:00:12.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:15:0)
[10:00:12.099] Timer tick, asking Buildbucket for the build status
[10:00:12.287] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:12.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:16:0) after 1m0s
[10:01:12.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:16:0)
[10:01:12.309] Timer tick, asking Buildbucket for the build status
[10:01:12.352] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:12.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:17:0) after 1m0s
[10:02:12.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:17:0)
[10:02:12.383] Timer tick, asking Buildbucket for the build status
[10:02:12.474] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:12.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:18:0) after 1m0s
[10:03:12.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:18:0)
[10:03:12.494] Timer tick, asking Buildbucket for the build status
[10:03:12.577] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:12.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:19:0) after 1m0s
[10:04:12.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:19:0)
[10:04:12.608] Timer tick, asking Buildbucket for the build status
[10:04:12.702] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:12.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:20:0) after 1m0s
[10:05:12.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:20:0)
[10:05:12.728] Timer tick, asking Buildbucket for the build status
[10:05:12.775] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:12.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:21:0) after 1m0s
[10:06:12.792] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:21:0)
[10:06:12.792] Timer tick, asking Buildbucket for the build status
[10:06:13.342] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:13.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:22:0) after 1m0s
[10:07:13.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:22:0)
[10:07:13.357] Timer tick, asking Buildbucket for the build status
[10:07:13.443] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:13.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:23:0) after 1m0s
[10:08:13.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:23:0)
[10:08:13.464] Timer tick, asking Buildbucket for the build status
[10:08:13.536] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:13.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:24:0) after 1m0s
[10:09:13.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:24:0)
[10:09:13.577] Timer tick, asking Buildbucket for the build status
[10:09:13.679] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:13.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:25:0) after 1m0s
[10:10:13.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:25:0)
[10:10:13.700] Timer tick, asking Buildbucket for the build status
[10:10:13.998] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:13.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:26:0) after 1m0s
[10:11:14.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:26:0)
[10:11:14.021] Timer tick, asking Buildbucket for the build status
[10:11:14.117] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:14.117] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:27:0) after 1m0s
[10:12:14.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:27:0)
[10:12:14.212] Timer tick, asking Buildbucket for the build status
[10:12:14.328] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:14.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:28:0) after 1m0s
[10:13:14.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:28:0)
[10:13:14.371] Timer tick, asking Buildbucket for the build status
[10:13:14.433] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:14.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:29:0) after 1m0s
[10:14:14.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:29:0)
[10:14:14.462] Timer tick, asking Buildbucket for the build status
[10:14:14.546] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:14.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:30:0) after 1m0s
[10:15:14.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:30:0)
[10:15:14.570] Timer tick, asking Buildbucket for the build status
[10:15:14.649] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:14.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:31:0) after 1m0s
[10:16:14.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:31:0)
[10:16:14.670] Timer tick, asking Buildbucket for the build status
[10:16:14.818] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:14.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:32:0) after 1m0s
[10:17:14.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:32:0)
[10:17:14.847] Timer tick, asking Buildbucket for the build status
[10:17:15.019] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:15.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:33:0) after 1m0s
[10:18:15.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:33:0)
[10:18:15.043] Timer tick, asking Buildbucket for the build status
[10:18:15.103] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:15.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:34:0) after 1m0s
[10:19:15.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:34:0)
[10:19:15.128] Timer tick, asking Buildbucket for the build status
[10:19:15.274] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:15.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:35:0) after 1m0s
[10:20:15.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:35:0)
[10:20:15.295] Timer tick, asking Buildbucket for the build status
[10:20:15.406] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:15.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:36:0) after 1m0s
[10:21:15.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:36:0)
[10:21:15.531] Timer tick, asking Buildbucket for the build status
[10:21:15.721] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:15.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:37:0) after 1m0s
[10:22:15.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:37:0)
[10:22:15.773] Timer tick, asking Buildbucket for the build status
[10:22:15.879] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:15.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:38:0) after 1m0s
[10:23:15.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:38:0)
[10:23:15.911] Timer tick, asking Buildbucket for the build status
[10:23:15.976] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:15.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:39:0) after 1m0s
[10:24:16.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:39:0)
[10:24:16.018] Timer tick, asking Buildbucket for the build status
[10:24:16.085] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:16.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:40:0) after 1m0s
[10:25:16.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:40:0)
[10:25:16.152] Timer tick, asking Buildbucket for the build status
[10:25:16.329] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:16.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:41:0) after 1m0s
[10:26:16.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:41:0)
[10:26:16.891] Timer tick, asking Buildbucket for the build status
[10:26:17.235] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:17.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:42:0) after 1m0s
[10:27:17.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:42:0)
[10:27:17.914] Timer tick, asking Buildbucket for the build status
[10:27:17.974] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:17.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:43:0) after 1m0s
[10:28:18.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:43:0)
[10:28:18.338] Timer tick, asking Buildbucket for the build status
[10:28:18.487] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:18.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:44:0) after 1m0s
[10:29:18.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:44:0)
[10:29:18.531] Timer tick, asking Buildbucket for the build status
[10:29:18.610] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:18.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:45:0) after 1m0s
[10:30:18.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:45:0)
[10:30:18.973] Timer tick, asking Buildbucket for the build status
[10:30:19.042] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:19.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:46:0) after 1m0s
[10:31:19.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:46:0)
[10:31:19.958] Timer tick, asking Buildbucket for the build status
[10:31:20.093] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:20.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:47:0) after 1m0s
[10:32:20.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:47:0)
[10:32:20.927] Timer tick, asking Buildbucket for the build status
[10:32:20.999] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:20.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:48:0) after 1m0s
[10:33:21.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:48:0)
[10:33:21.827] Timer tick, asking Buildbucket for the build status
[10:33:21.866] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:21.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:49:0) after 1m0s
[10:34:22.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:49:0)
[10:34:22.967] Timer tick, asking Buildbucket for the build status
[10:34:23.091] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:23.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:50:0) after 1m0s
[10:35:24.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:50:0)
[10:35:24.027] Timer tick, asking Buildbucket for the build status
[10:35:24.097] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:24.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:51:0) after 1m0s
[10:36:24.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:51:0)
[10:36:24.228] Timer tick, asking Buildbucket for the build status
[10:36:24.283] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:24.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:52:0) after 1m0s
[10:37:24.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:52:0)
[10:37:24.713] Timer tick, asking Buildbucket for the build status
[10:37:24.782] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:24.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:53:0) after 1m0s
[10:38:25.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:53:0)
[10:38:25.521] Timer tick, asking Buildbucket for the build status
[10:38:25.590] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:25.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:54:0) after 1m0s
[10:39:25.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:54:0)
[10:39:25.996] Timer tick, asking Buildbucket for the build status
[10:39:26.087] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:26.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:55:0) after 1m0s
[10:40:27.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:55:0)
[10:40:27.405] Timer tick, asking Buildbucket for the build status
[10:40:27.487] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:27.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:56:0) after 1m0s
[10:41:28.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:56:0)
[10:41:28.079] Timer tick, asking Buildbucket for the build status
[10:41:28.155] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:28.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:57:0) after 1m0s
[10:42:28.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:57:0)
[10:42:28.771] Timer tick, asking Buildbucket for the build status
[10:42:28.842] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:28.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:58:0) after 1m0s
[10:43:29.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:58:0)
[10:43:29.197] Timer tick, asking Buildbucket for the build status
[10:43:29.374] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:29.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:59:0) after 1m0s
[10:44:30.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:59:0)
[10:44:30.206] Timer tick, asking Buildbucket for the build status
[10:44:30.351] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:30.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:60:0) after 1m0s
[10:45:30.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:60:0)
[10:45:30.840] Timer tick, asking Buildbucket for the build status
[10:45:30.890] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:30.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:61:0) after 1m0s
[10:46:30.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:61:0)
[10:46:30.914] Timer tick, asking Buildbucket for the build status
[10:46:30.969] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:30.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:62:0) after 1m0s
[10:47:31.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:62:0)
[10:47:31.434] Timer tick, asking Buildbucket for the build status
[10:47:31.508] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:31.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:63:0) after 1m0s
[10:48:31.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:63:0)
[10:48:31.533] Timer tick, asking Buildbucket for the build status
[10:48:31.604] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:31.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:64:0) after 1m0s
[10:49:31.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:64:0)
[10:49:31.649] Timer tick, asking Buildbucket for the build status
[10:49:31.703] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:31.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:65:0) after 1m0s
[10:50:31.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:65:0)
[10:50:31.732] Timer tick, asking Buildbucket for the build status
[10:50:31.839] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:31.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:66:0) after 1m0s
[10:51:32.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:66:0)
[10:51:32.422] Timer tick, asking Buildbucket for the build status
[10:51:32.589] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:32.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:67:0) after 1m0s
[10:52:33.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:67:0)
[10:52:33.138] Timer tick, asking Buildbucket for the build status
[10:52:33.197] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:33.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:68:0) after 1m0s
[10:53:33.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:68:0)
[10:53:33.986] Timer tick, asking Buildbucket for the build status
[10:53:34.180] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:34.180] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:69:0) after 1m0s
[10:54:34.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:69:0)
[10:54:34.989] Timer tick, asking Buildbucket for the build status
[10:54:35.076] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:35.076] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:70:0) after 1m0s
[10:55:35.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:70:0)
[10:55:35.924] Timer tick, asking Buildbucket for the build status
[10:55:35.990] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:35.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:71:0) after 1m0s
[10:56:36.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:71:0)
[10:56:36.624] Timer tick, asking Buildbucket for the build status
[10:56:36.809] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:36.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:72:0) after 1m0s
[10:57:37.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:72:0)
[10:57:37.516] Timer tick, asking Buildbucket for the build status
[10:57:37.563] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:37.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:73:0) after 1m0s
[10:58:38.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:73:0)
[10:58:38.395] Timer tick, asking Buildbucket for the build status
[10:58:38.521] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:38.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:74:0) after 1m0s
[10:59:39.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:74:0)
[10:59:39.134] Timer tick, asking Buildbucket for the build status
[10:59:39.204] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:39.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:75:0) after 1m0s
[11:00:39.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:75:0)
[11:00:39.724] Timer tick, asking Buildbucket for the build status
[11:00:39.800] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:39.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:76:0) after 1m0s
[11:01:40.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:76:0)
[11:01:40.833] Timer tick, asking Buildbucket for the build status
[11:01:40.899] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:40.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:77:0) after 1m0s
[11:02:40.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:77:0)
[11:02:40.933] Timer tick, asking Buildbucket for the build status
[11:02:41.122] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:41.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:78:0) after 1m0s
[11:03:41.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:78:0)
[11:03:41.217] Timer tick, asking Buildbucket for the build status
[11:03:41.291] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:41.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:79:0) after 1m0s
[11:04:41.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:79:0)
[11:04:41.905] Timer tick, asking Buildbucket for the build status
[11:04:41.993] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:41.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:80:0) after 1m0s
[11:05:42.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:80:0)
[11:05:42.721] Timer tick, asking Buildbucket for the build status
[11:05:42.764] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:42.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:81:0) after 1m0s
[11:06:43.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:81:0)
[11:06:43.450] Timer tick, asking Buildbucket for the build status
[11:06:43.607] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:43.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:82:0) after 1m0s
[11:07:44.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:82:0)
[11:07:44.545] Timer tick, asking Buildbucket for the build status
[11:07:44.616] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:44.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:83:0) after 1m0s
[11:08:45.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:83:0)
[11:08:45.184] Timer tick, asking Buildbucket for the build status
[11:08:45.351] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:45.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:84:0) after 1m0s
[11:09:46.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:84:0)
[11:09:46.028] Timer tick, asking Buildbucket for the build status
[11:09:46.146] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:46.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:85:0) after 1m0s
[11:10:46.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:85:0)
[11:10:46.876] Timer tick, asking Buildbucket for the build status
[11:10:46.955] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:46.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:86:0) after 1m0s
[11:11:47.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:86:0)
[11:11:47.712] Timer tick, asking Buildbucket for the build status
[11:11:47.849] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:47.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:87:0) after 1m0s
[11:12:48.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:87:0)
[11:12:48.734] Timer tick, asking Buildbucket for the build status
[11:12:48.930] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:48.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:88:0) after 1m0s
[11:13:49.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:88:0)
[11:13:49.602] Timer tick, asking Buildbucket for the build status
[11:13:49.754] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:49.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:89:0) after 1m0s
[11:14:50.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:89:0)
[11:14:50.535] Timer tick, asking Buildbucket for the build status
[11:14:50.795] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:50.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:90:0) after 1m0s
[11:15:51.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:90:0)
[11:15:51.162] Timer tick, asking Buildbucket for the build status
[11:15:51.198] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:51.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:91:0) after 1m0s
[11:16:52.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:91:0)
[11:16:52.191] Timer tick, asking Buildbucket for the build status
[11:16:52.436] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:52.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:92:0) after 1m0s
[11:17:52.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:92:0)
[11:17:52.455] Timer tick, asking Buildbucket for the build status
[11:17:52.532] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:52.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:93:0) after 1m0s
[11:18:52.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:93:0)
[11:18:52.556] Timer tick, asking Buildbucket for the build status
[11:18:52.632] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:52.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:94:0) after 1m0s
[11:19:53.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:94:0)
[11:19:53.368] Timer tick, asking Buildbucket for the build status
[11:19:53.429] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:53.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:95:0) after 1m0s
[11:20:54.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:95:0)
[11:20:54.290] Timer tick, asking Buildbucket for the build status
[11:20:54.394] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:54.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:96:0) after 1m0s
[11:21:54.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:96:0)
[11:21:54.445] Timer tick, asking Buildbucket for the build status
[11:21:54.625] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:54.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:97:0) after 1m0s
[11:22:54.978] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:97:0)
[11:22:54.978] Timer tick, asking Buildbucket for the build status
[11:22:55.041] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:55.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:98:0) after 1m0s
[11:23:55.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:98:0)
[11:23:55.652] Timer tick, asking Buildbucket for the build status
[11:23:55.845] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:55.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:99:0) after 1m0s
[11:24:56.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:99:0)
[11:24:56.615] Timer tick, asking Buildbucket for the build status
[11:24:56.880] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:56.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:100:0) after 1m0s
[11:25:57.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:100:0)
[11:25:57.457] Timer tick, asking Buildbucket for the build status
[11:25:57.525] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:57.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:101:0) after 1m0s
[11:26:58.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:101:0)
[11:26:58.106] Timer tick, asking Buildbucket for the build status
[11:26:58.305] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:58.305] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:102:0) after 1m0s
[11:27:58.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:102:0)
[11:27:58.970] Timer tick, asking Buildbucket for the build status
[11:27:59.060] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:59.060] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:103:0) after 1m0s
[11:28:59.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:103:0)
[11:28:59.924] Timer tick, asking Buildbucket for the build status
[11:28:59.984] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:59.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:104:0) after 1m0s
[11:30:00.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:104:0)
[11:30:00.695] Timer tick, asking Buildbucket for the build status
[11:30:00.781] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:00.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:105:0) after 1m0s
[11:31:01.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:105:0)
[11:31:01.519] Timer tick, asking Buildbucket for the build status
[11:31:01.842] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:01.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:106:0) after 1m0s
[11:32:02.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:106:0)
[11:32:02.454] Timer tick, asking Buildbucket for the build status
[11:32:02.529] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:02.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:107:0) after 1m0s
[11:33:03.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:107:0)
[11:33:03.257] Timer tick, asking Buildbucket for the build status
[11:33:03.330] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:03.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:108:0) after 1m0s
[11:34:03.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:108:0)
[11:34:03.365] Timer tick, asking Buildbucket for the build status
[11:34:03.695] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:03.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:109:0) after 1m0s
[11:35:03.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:109:0)
[11:35:03.725] Timer tick, asking Buildbucket for the build status
[11:35:03.800] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:03.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:110:0) after 1m0s
[11:36:03.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:110:0)
[11:36:03.911] Timer tick, asking Buildbucket for the build status
[11:36:04.329] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:04.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:111:0) after 1m0s
[11:37:04.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:111:0)
[11:37:04.593] Timer tick, asking Buildbucket for the build status
[11:37:04.710] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:04.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:112:0) after 1m0s
[11:38:05.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:112:0)
[11:38:05.374] Timer tick, asking Buildbucket for the build status
[11:38:05.525] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:05.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:113:0) after 1m0s
[11:39:06.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:113:0)
[11:39:06.255] Timer tick, asking Buildbucket for the build status
[11:39:06.354] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:06.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:114:0) after 1m0s
[11:40:06.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:114:0)
[11:40:06.397] Timer tick, asking Buildbucket for the build status
[11:40:06.490] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:06.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:115:0) after 1m0s
[11:41:06.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:115:0)
[11:41:06.522] Timer tick, asking Buildbucket for the build status
[11:41:06.716] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:06.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:116:0) after 1m0s
[11:42:06.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:116:0)
[11:42:06.812] Timer tick, asking Buildbucket for the build status
[11:42:06.876] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:06.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:117:0) after 1m0s
[11:43:06.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:117:0)
[11:43:06.911] Timer tick, asking Buildbucket for the build status
[11:43:06.999] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:06.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:118:0) after 1m0s
[11:44:07.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:118:0)
[11:44:07.026] Timer tick, asking Buildbucket for the build status
[11:44:07.091] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:07.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:119:0) after 1m0s
[11:45:07.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:119:0)
[11:45:07.150] Timer tick, asking Buildbucket for the build status
[11:45:07.248] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:07.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:120:0) after 1m0s
[11:46:07.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:120:0)
[11:46:07.450] Timer tick, asking Buildbucket for the build status
[11:46:07.559] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:07.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:121:0) after 1m0s
[11:47:07.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:121:0)
[11:47:07.604] Timer tick, asking Buildbucket for the build status
[11:47:07.645] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:07.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:122:0) after 1m0s
[11:48:07.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:122:0)
[11:48:07.687] Timer tick, asking Buildbucket for the build status
[11:48:07.767] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:07.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:123:0) after 1m0s
[11:49:08.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:123:0)
[11:49:08.423] Timer tick, asking Buildbucket for the build status
[11:49:08.662] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:08.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:124:0) after 1m0s
[11:50:09.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:124:0)
[11:50:09.263] Timer tick, asking Buildbucket for the build status
[11:50:09.324] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:09.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:125:0) after 1m0s
[11:51:09.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:125:0)
[11:51:09.345] Timer tick, asking Buildbucket for the build status
[11:51:09.407] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:09.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:126:0) after 1m0s
[11:52:09.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:126:0)
[11:52:09.429] Timer tick, asking Buildbucket for the build status
[11:52:09.605] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:09.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:127:0) after 1m0s
[11:53:09.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:127:0)
[11:53:09.699] Timer tick, asking Buildbucket for the build status
[11:53:09.883] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:09.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:128:0) after 1m0s
[11:54:09.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:128:0)
[11:54:09.911] Timer tick, asking Buildbucket for the build status
[11:54:10.047] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:10.047] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:129:0) after 1m0s
[11:55:10.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:129:0)
[11:55:10.067] Timer tick, asking Buildbucket for the build status
[11:55:10.125] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:10.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:130:0) after 1m0s
[11:56:10.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:130:0)
[11:56:10.197] Timer tick, asking Buildbucket for the build status
[11:56:10.298] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:10.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:131:0) after 1m0s
[11:57:10.332] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:131:0)
[11:57:10.332] Timer tick, asking Buildbucket for the build status
[11:57:10.516] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:10.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:132:0) after 1m0s
[11:58:10.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:132:0)
[11:58:10.541] Timer tick, asking Buildbucket for the build status
[11:58:10.601] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:10.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:133:0) after 1m0s
[11:59:10.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:133:0)
[11:59:10.623] Timer tick, asking Buildbucket for the build status
[11:59:10.813] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:10.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:134:0) after 1m0s
[12:00:10.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:134:0)
[12:00:10.842] Timer tick, asking Buildbucket for the build status
[12:00:10.983] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:10.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:135:0) after 1m0s
[12:01:11.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:135:0)
[12:01:11.006] Timer tick, asking Buildbucket for the build status
[12:01:11.094] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:11.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:136:0) after 1m0s
[12:02:11.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:136:0)
[12:02:11.116] Timer tick, asking Buildbucket for the build status
[12:02:11.402] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:11.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:137:0) after 1m0s
[12:03:11.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:137:0)
[12:03:11.433] Timer tick, asking Buildbucket for the build status
[12:03:11.518] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:11.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:138:0) after 1m0s
[12:04:11.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:138:0)
[12:04:11.545] Timer tick, asking Buildbucket for the build status
[12:04:11.693] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:11.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:139:0) after 1m0s
[12:05:11.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:139:0)
[12:05:11.713] Timer tick, asking Buildbucket for the build status
[12:05:11.889] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:11.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:140:0) after 1m0s
[12:06:11.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:140:0)
[12:06:11.916] Timer tick, asking Buildbucket for the build status
[12:06:11.999] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:11.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:141:0) after 1m0s
[12:07:12.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:141:0)
[12:07:12.088] Timer tick, asking Buildbucket for the build status
[12:07:12.173] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:12.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:142:0) after 1m0s
[12:08:12.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:142:0)
[12:08:12.210] Timer tick, asking Buildbucket for the build status
[12:08:12.314] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:12.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:143:0) after 1m0s
[12:09:12.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:143:0)
[12:09:12.341] Timer tick, asking Buildbucket for the build status
[12:09:12.406] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:12.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:144:0) after 1m0s
[12:10:12.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:144:0)
[12:10:12.440] Timer tick, asking Buildbucket for the build status
[12:10:12.544] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:12.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:145:0) after 1m0s
[12:11:12.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:145:0)
[12:11:12.574] Timer tick, asking Buildbucket for the build status
[12:11:12.780] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:12.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:146:0) after 1m0s
[12:12:12.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:146:0)
[12:12:12.989] Timer tick, asking Buildbucket for the build status
[12:12:13.203] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:13.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:147:0) after 1m0s
[12:13:13.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:147:0)
[12:13:13.237] Timer tick, asking Buildbucket for the build status
[12:13:13.486] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:13.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:148:0) after 1m0s
[12:14:13.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:148:0)
[12:14:13.507] Timer tick, asking Buildbucket for the build status
[12:14:13.567] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:13.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:149:0) after 1m0s
[12:15:13.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:149:0)
[12:15:13.595] Timer tick, asking Buildbucket for the build status
[12:15:13.686] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:13.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:150:0) after 1m0s
[12:16:13.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:150:0)
[12:16:13.711] Timer tick, asking Buildbucket for the build status
[12:16:13.800] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:13.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:151:0) after 1m0s
[12:17:13.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:151:0)
[12:17:13.825] Timer tick, asking Buildbucket for the build status
[12:17:13.953] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:13.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:152:0) after 1m0s
[12:18:13.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:152:0)
[12:18:13.977] Timer tick, asking Buildbucket for the build status
[12:18:14.067] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:14.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:153:0) after 1m0s
[12:19:14.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:153:0)
[12:19:14.089] Timer tick, asking Buildbucket for the build status
[12:19:14.234] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:14.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:154:0) after 1m0s
[12:20:14.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:154:0)
[12:20:14.298] Timer tick, asking Buildbucket for the build status
[12:20:14.442] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:14.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:155:0) after 1m0s
[12:21:14.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:155:0)
[12:21:14.472] Timer tick, asking Buildbucket for the build status
[12:21:14.554] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:14.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:156:0) after 1m0s
[12:22:14.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:156:0)
[12:22:14.575] Timer tick, asking Buildbucket for the build status
[12:22:14.766] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:14.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:157:0) after 1m0s
[12:23:14.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:157:0)
[12:23:14.789] Timer tick, asking Buildbucket for the build status
[12:23:14.893] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:14.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:158:0) after 1m0s
[12:24:14.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:158:0)
[12:24:14.957] Timer tick, asking Buildbucket for the build status
[12:24:15.129] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:15.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:159:0) after 1m0s
[12:25:15.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:159:0)
[12:25:15.163] Timer tick, asking Buildbucket for the build status
[12:25:15.226] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:15.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:160:0) after 1m0s
[12:26:15.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:160:0)
[12:26:15.251] Timer tick, asking Buildbucket for the build status
[12:26:15.379] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:15.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:161:0) after 1m0s
[12:27:15.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:161:0)
[12:27:15.410] Timer tick, asking Buildbucket for the build status
[12:27:15.533] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:15.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:162:0) after 1m0s
[12:28:15.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:162:0)
[12:28:15.625] Timer tick, asking Buildbucket for the build status
[12:28:15.853] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:15.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:163:0) after 1m0s
[12:29:15.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:163:0)
[12:29:15.874] Timer tick, asking Buildbucket for the build status
[12:29:15.951] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:15.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:164:0) after 1m0s
[12:30:15.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:164:0)
[12:30:15.982] Timer tick, asking Buildbucket for the build status
[12:30:16.040] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:16.040] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:165:0) after 1m0s
[12:31:16.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:165:0)
[12:31:16.196] Timer tick, asking Buildbucket for the build status
[12:31:16.338] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:16.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:166:0) after 1m0s
[12:32:16.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:166:0)
[12:32:16.417] Timer tick, asking Buildbucket for the build status
[12:32:16.563] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:16.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:167:0) after 1m0s
[12:33:16.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:167:0)
[12:33:16.668] Timer tick, asking Buildbucket for the build status
[12:33:16.821] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:16.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:168:0) after 1m0s
[12:34:16.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:168:0)
[12:34:16.875] Timer tick, asking Buildbucket for the build status
[12:34:17.121] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:17.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:169:0) after 1m0s
[12:35:17.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:169:0)
[12:35:17.205] Timer tick, asking Buildbucket for the build status
[12:35:17.272] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:17.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:170:0) after 1m0s
[12:36:17.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:170:0)
[12:36:17.297] Timer tick, asking Buildbucket for the build status
[12:36:17.491] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:17.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:171:0) after 1m0s
[12:37:17.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:171:0)
[12:37:17.537] Timer tick, asking Buildbucket for the build status
[12:37:17.718] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:17.718] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:172:0) after 1m0s
[12:38:17.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:172:0)
[12:38:17.739] Timer tick, asking Buildbucket for the build status
[12:38:17.891] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:17.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:173:0) after 1m0s
[12:39:17.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:173:0)
[12:39:17.992] Timer tick, asking Buildbucket for the build status
[12:39:18.079] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:18.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:174:0) after 1m0s
[12:40:18.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:174:0)
[12:40:18.185] Timer tick, asking Buildbucket for the build status
[12:40:18.288] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:18.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:175:0) after 1m0s
[12:41:18.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:175:0)
[12:41:18.329] Timer tick, asking Buildbucket for the build status
[12:41:18.388] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:18.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:176:0) after 1m0s
[12:42:18.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:176:0)
[12:42:18.416] Timer tick, asking Buildbucket for the build status
[12:42:18.541] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:18.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:177:0) after 1m0s
[12:43:18.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:177:0)
[12:43:18.562] Timer tick, asking Buildbucket for the build status
[12:43:18.816] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:18.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:178:0) after 1m0s
[12:44:18.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:178:0)
[12:44:18.841] Timer tick, asking Buildbucket for the build status
[12:44:19.112] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:19.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:179:0) after 1m0s
[12:45:19.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:179:0)
[12:45:19.138] Timer tick, asking Buildbucket for the build status
[12:45:19.219] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:19.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:180:0) after 1m0s
[12:46:19.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:180:0)
[12:46:19.290] Timer tick, asking Buildbucket for the build status
[12:46:19.614] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:19.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:181:0) after 1m0s
[12:47:19.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:181:0)
[12:47:19.639] Timer tick, asking Buildbucket for the build status
[12:47:19.835] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:19.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:182:0) after 1m0s
[12:48:19.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:182:0)
[12:48:19.861] Timer tick, asking Buildbucket for the build status
[12:48:20.217] Build 8930888088364237168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:20.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096318150485091568:183:0) after 1m0s
[12:49:17.223] Received PubSub notification, asking Buildbucket for the build status
[12:49:17.273] Build 8930888088364237168: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[12:49:17.273] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "completed_ts": "1541249356210934",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1541238429636766",
    "failure_reason": "INFRA_FAILURE",
    "id": "8930888088364237168",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"72.0.3600.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-west\", \"us-west1\", \"us-west1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-e833d7b0-us-west1-b-rg94\"], \"pool\": [\"luci.infra.cron\"], \"caches\": [\"vpython\"]}}, \"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1541238485108881",
    "status": "COMPLETED",
    "status_changed_ts": "1541249356724546",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9096318150485091568",
      "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:8930888088364237168",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
      "swarming_tag:builder:Build From Tarball",
      "swarming_tag:caches:builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8930888088364237168/+/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:9096318150485091568",
      "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:ec92cebceb578036635bdb39ec91102625e5b767",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:user_agent:recipe",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:40f1c9a16dfb7d10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1541249356725733",
    "url": "https://ci.chromium.org/b/8930888088364237168",
    "utcnow_ts": "1541249357263336"
  }
}
[12:49:17.274] Invocation finished in 3h2m9.04305255s with status FAILED