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

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

{
  "version": "70.0.3538.46"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[04:25:38.353] New invocation is queued and will start shortly
[04:25:38.353] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[04:25:39.595] Starting the invocation (attempt 1)
[04:25:39.682] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:25:39.682] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:25:39.682] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9099056286396270736",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"70.0.3538.46\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9099056286396270736",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[04:25:40.693] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1538627139746465",
    "id": "8933626224272350944",
    "lease_expiration_ts": "1538745940525298",
    "lease_key": "1023050176",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"70.0.3538.46\"}}",
    "project": "infra",
    "result_details_json": "null",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1538627140564087",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9099056286396270736",
      "scheduler_job_id:infra/Build From Tarball",
      "swarming_dimension:builder:Build From Tarball",
      "swarming_dimension:caches:builder_99d5fe30e8b6c78ca136ab5e547c67467b176b4f7d67cf49cf682cf48a330f19_v2",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.infra.cron",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:buildbucket_bucket:luci.infra.cron",
      "swarming_tag:buildbucket_build_id:8933626224272350944",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
      "swarming_tag:builder:Build From Tarball",
      "swarming_tag:caches:builder_99d5fe30e8b6c78ca136ab5e547c67467b176b4f7d67cf49cf682cf48a330f19_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8933626224272350944/+/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:9099056286396270736",
      "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:f18910c956967c1117c52a51c48c33e3a3046ca4",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:user_agent:recipe",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:40562482b4d29e10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1538627140564291",
    "url": "https://ci.chromium.org/p/infra/builds/b8933626224272350944",
    "utcnow_ts": "1538627140677967"
  }
}
[04:25:40.693] Task URL: https://ci.chromium.org/p/infra/builds/b8933626224272350944
[04:25:40.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:2:0) after 1m0s
[04:26:04.125] Received PubSub notification, asking Buildbucket for the build status
[04:26:04.308] Build 8933626224272350944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:40.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:2:0)
[04:26:40.719] Timer tick, asking Buildbucket for the build status
[04:26:40.755] Build 8933626224272350944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:40.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:4:0) after 1m0s
[04:27:35.548] Received PubSub notification, asking Buildbucket for the build status
[04:27:35.616] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:40.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:4:0)
[04:27:40.777] Timer tick, asking Buildbucket for the build status
[04:27:41.213] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:41.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:6:0) after 1m0s
[04:28:41.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:6:0)
[04:28:41.233] Timer tick, asking Buildbucket for the build status
[04:28:41.399] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:41.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:7:0) after 1m0s
[04:29:41.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:7:0)
[04:29:41.459] Timer tick, asking Buildbucket for the build status
[04:29:41.541] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:41.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:8:0) after 1m0s
[04:30:41.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:8:0)
[04:30:41.617] Timer tick, asking Buildbucket for the build status
[04:30:41.655] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:41.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:9:0) after 1m0s
[04:31:41.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:9:0)
[04:31:41.673] Timer tick, asking Buildbucket for the build status
[04:31:41.801] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:41.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:10:0) after 1m0s
[04:32:41.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:10:0)
[04:32:41.820] Timer tick, asking Buildbucket for the build status
[04:32:41.880] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:41.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:11:0) after 1m0s
[04:33:41.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:11:0)
[04:33:41.905] Timer tick, asking Buildbucket for the build status
[04:33:42.070] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:42.070] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:12:0) after 1m0s
[04:34:42.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:12:0)
[04:34:42.085] Timer tick, asking Buildbucket for the build status
[04:34:42.138] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:42.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:13:0) after 1m0s
[04:35:42.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:13:0)
[04:35:42.152] Timer tick, asking Buildbucket for the build status
[04:35:42.214] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:42.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:14:0) after 1m0s
[04:36:42.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:14:0)
[04:36:42.249] Timer tick, asking Buildbucket for the build status
[04:36:42.313] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:42.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:15:0) after 1m0s
[04:37:42.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:15:0)
[04:37:42.348] Timer tick, asking Buildbucket for the build status
[04:37:42.398] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:42.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:16:0) after 1m0s
[04:38:42.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:16:0)
[04:38:42.417] Timer tick, asking Buildbucket for the build status
[04:38:42.609] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:42.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:17:0) after 1m0s
[04:39:42.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:17:0)
[04:39:42.633] Timer tick, asking Buildbucket for the build status
[04:39:42.708] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:42.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:18:0) after 1m0s
[04:40:42.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:18:0)
[04:40:42.722] Timer tick, asking Buildbucket for the build status
[04:40:42.795] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:42.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:19:0) after 1m0s
[04:41:42.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:19:0)
[04:41:42.834] Timer tick, asking Buildbucket for the build status
[04:41:43.076] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:43.076] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:20:0) after 1m0s
[04:42:43.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:20:0)
[04:42:43.096] Timer tick, asking Buildbucket for the build status
[04:42:43.132] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:43.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:21:0) after 1m0s
[04:43:43.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:21:0)
[04:43:43.154] Timer tick, asking Buildbucket for the build status
[04:43:43.193] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:43.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:22:0) after 1m0s
[04:44:43.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:22:0)
[04:44:43.211] Timer tick, asking Buildbucket for the build status
[04:44:43.288] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:43.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:23:0) after 1m0s
[04:45:43.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:23:0)
[04:45:43.401] Timer tick, asking Buildbucket for the build status
[04:45:43.455] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:43.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:24:0) after 1m0s
[04:46:43.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:24:0)
[04:46:43.476] Timer tick, asking Buildbucket for the build status
[04:46:43.567] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:43.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:25:0) after 1m0s
[04:47:43.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:25:0)
[04:47:43.597] Timer tick, asking Buildbucket for the build status
[04:47:43.650] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:43.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:26:0) after 1m0s
[04:48:43.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:26:0)
[04:48:43.668] Timer tick, asking Buildbucket for the build status
[04:48:43.802] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:43.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:27:0) after 1m0s
[04:49:43.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:27:0)
[04:49:43.832] Timer tick, asking Buildbucket for the build status
[04:49:43.869] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:43.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:28:0) after 1m0s
[04:50:43.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:28:0)
[04:50:43.886] Timer tick, asking Buildbucket for the build status
[04:50:43.940] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:43.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:29:0) after 1m0s
[04:51:43.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:29:0)
[04:51:43.961] Timer tick, asking Buildbucket for the build status
[04:51:44.171] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:44.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:30:0) after 1m0s
[04:52:44.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:30:0)
[04:52:44.215] Timer tick, asking Buildbucket for the build status
[04:52:44.389] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:44.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:31:0) after 1m0s
[04:53:44.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:31:0)
[04:53:44.414] Timer tick, asking Buildbucket for the build status
[04:53:44.711] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:44.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:32:0) after 1m0s
[04:54:44.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:32:0)
[04:54:44.729] Timer tick, asking Buildbucket for the build status
[04:54:44.761] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:44.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:33:0) after 1m0s
[04:55:44.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:33:0)
[04:55:44.785] Timer tick, asking Buildbucket for the build status
[04:55:44.827] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:44.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:34:0) after 1m0s
[04:56:44.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:34:0)
[04:56:44.851] Timer tick, asking Buildbucket for the build status
[04:56:44.953] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:44.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:35:0) after 1m0s
[04:57:44.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:35:0)
[04:57:44.976] Timer tick, asking Buildbucket for the build status
[04:57:45.187] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:45.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:36:0) after 1m0s
[04:58:45.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:36:0)
[04:58:45.235] Timer tick, asking Buildbucket for the build status
[04:58:45.371] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:45.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:37:0) after 1m0s
[04:59:45.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:37:0)
[04:59:45.393] Timer tick, asking Buildbucket for the build status
[04:59:45.567] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:45.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:38:0) after 1m0s
[05:00:45.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:38:0)
[05:00:45.595] Timer tick, asking Buildbucket for the build status
[05:00:45.707] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:45.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:39:0) after 1m0s
[05:01:45.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:39:0)
[05:01:45.728] Timer tick, asking Buildbucket for the build status
[05:01:45.916] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:45.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:40:0) after 1m0s
[05:02:45.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:40:0)
[05:02:45.935] Timer tick, asking Buildbucket for the build status
[05:02:46.022] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:46.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:41:0) after 1m0s
[05:03:46.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:41:0)
[05:03:46.047] Timer tick, asking Buildbucket for the build status
[05:03:46.175] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:46.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:42:0) after 1m0s
[05:04:46.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:42:0)
[05:04:46.213] Timer tick, asking Buildbucket for the build status
[05:04:46.254] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:46.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:43:0) after 1m0s
[05:05:46.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:43:0)
[05:05:46.276] Timer tick, asking Buildbucket for the build status
[05:05:46.343] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:46.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:44:0) after 1m0s
[05:06:46.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:44:0)
[05:06:46.398] Timer tick, asking Buildbucket for the build status
[05:06:46.445] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:46.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:45:0) after 1m0s
[05:07:46.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:45:0)
[05:07:46.518] Timer tick, asking Buildbucket for the build status
[05:07:46.581] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:46.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:46:0) after 1m0s
[05:08:46.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:46:0)
[05:08:46.602] Timer tick, asking Buildbucket for the build status
[05:08:46.737] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:46.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:47:0) after 1m0s
[05:09:46.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:47:0)
[05:09:46.758] Timer tick, asking Buildbucket for the build status
[05:09:46.799] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:46.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:48:0) after 1m0s
[05:10:46.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:48:0)
[05:10:46.851] Timer tick, asking Buildbucket for the build status
[05:10:46.898] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:46.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:49:0) after 1m0s
[05:11:46.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:49:0)
[05:11:46.922] Timer tick, asking Buildbucket for the build status
[05:11:47.066] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:47.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:50:0) after 1m0s
[05:12:47.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:50:0)
[05:12:47.123] Timer tick, asking Buildbucket for the build status
[05:12:47.164] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:47.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:51:0) after 1m0s
[05:13:47.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:51:0)
[05:13:47.199] Timer tick, asking Buildbucket for the build status
[05:13:47.401] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:47.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:52:0) after 1m0s
[05:14:47.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:52:0)
[05:14:47.421] Timer tick, asking Buildbucket for the build status
[05:14:47.490] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:47.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:53:0) after 1m0s
[05:15:47.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:53:0)
[05:15:47.567] Timer tick, asking Buildbucket for the build status
[05:15:47.649] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:47.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:54:0) after 1m0s
[05:16:47.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:54:0)
[05:16:47.750] Timer tick, asking Buildbucket for the build status
[05:16:47.835] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:47.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:55:0) after 1m0s
[05:17:47.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:55:0)
[05:17:47.868] Timer tick, asking Buildbucket for the build status
[05:17:47.943] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:47.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:56:0) after 1m0s
[05:18:47.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:56:0)
[05:18:47.971] Timer tick, asking Buildbucket for the build status
[05:18:48.036] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:48.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:57:0) after 1m0s
[05:19:48.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:57:0)
[05:19:48.117] Timer tick, asking Buildbucket for the build status
[05:19:48.218] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:48.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:58:0) after 1m0s
[05:20:48.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:58:0)
[05:20:48.241] Timer tick, asking Buildbucket for the build status
[05:20:48.309] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:48.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:59:0) after 1m0s
[05:21:48.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:59:0)
[05:21:48.330] Timer tick, asking Buildbucket for the build status
[05:21:48.407] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:48.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:60:0) after 1m0s
[05:22:48.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:60:0)
[05:22:48.431] Timer tick, asking Buildbucket for the build status
[05:22:48.488] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:48.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:61:0) after 1m0s
[05:23:48.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:61:0)
[05:23:48.544] Timer tick, asking Buildbucket for the build status
[05:23:48.740] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:48.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:62:0) after 1m0s
[05:24:48.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:62:0)
[05:24:48.763] Timer tick, asking Buildbucket for the build status
[05:24:48.838] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:48.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:63:0) after 1m0s
[05:25:48.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:63:0)
[05:25:48.861] Timer tick, asking Buildbucket for the build status
[05:25:48.977] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:48.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:64:0) after 1m0s
[05:26:48.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:64:0)
[05:26:48.998] Timer tick, asking Buildbucket for the build status
[05:26:49.054] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:49.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:65:0) after 1m0s
[05:27:49.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:65:0)
[05:27:49.105] Timer tick, asking Buildbucket for the build status
[05:27:49.163] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:49.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:66:0) after 1m0s
[05:28:49.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:66:0)
[05:28:49.179] Timer tick, asking Buildbucket for the build status
[05:28:49.319] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:49.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:67:0) after 1m0s
[05:29:49.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:67:0)
[05:29:49.353] Timer tick, asking Buildbucket for the build status
[05:29:49.414] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:49.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:68:0) after 1m0s
[05:30:49.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:68:0)
[05:30:49.430] Timer tick, asking Buildbucket for the build status
[05:30:49.495] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:49.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:69:0) after 1m0s
[05:31:49.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:69:0)
[05:31:49.512] Timer tick, asking Buildbucket for the build status
[05:31:49.590] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:49.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:70:0) after 1m0s
[05:32:49.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:70:0)
[05:32:49.607] Timer tick, asking Buildbucket for the build status
[05:32:49.649] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:49.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:71:0) after 1m0s
[05:33:49.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:71:0)
[05:33:49.672] Timer tick, asking Buildbucket for the build status
[05:33:49.737] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:49.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:72:0) after 1m0s
[05:34:49.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:72:0)
[05:34:49.756] Timer tick, asking Buildbucket for the build status
[05:34:49.812] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:49.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:73:0) after 1m0s
[05:35:49.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:73:0)
[05:35:49.834] Timer tick, asking Buildbucket for the build status
[05:35:49.893] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:49.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:74:0) after 1m0s
[05:36:49.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:74:0)
[05:36:49.916] Timer tick, asking Buildbucket for the build status
[05:36:50.054] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:50.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:75:0) after 1m0s
[05:37:50.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:75:0)
[05:37:50.069] Timer tick, asking Buildbucket for the build status
[05:37:50.126] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:50.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:76:0) after 1m0s
[05:38:50.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:76:0)
[05:38:50.143] Timer tick, asking Buildbucket for the build status
[05:38:50.189] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:50.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:77:0) after 1m0s
[05:39:50.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:77:0)
[05:39:50.209] Timer tick, asking Buildbucket for the build status
[05:39:50.277] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:50.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:78:0) after 1m0s
[05:40:50.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:78:0)
[05:40:50.295] Timer tick, asking Buildbucket for the build status
[05:40:50.463] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:50.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:79:0) after 1m0s
[05:41:50.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:79:0)
[05:41:50.516] Timer tick, asking Buildbucket for the build status
[05:41:50.573] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:50.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:80:0) after 1m0s
[05:42:50.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:80:0)
[05:42:50.592] Timer tick, asking Buildbucket for the build status
[05:42:50.656] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:50.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:81:0) after 1m0s
[05:43:50.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:81:0)
[05:43:50.676] Timer tick, asking Buildbucket for the build status
[05:43:50.727] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:50.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:82:0) after 1m0s
[05:44:50.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:82:0)
[05:44:50.755] Timer tick, asking Buildbucket for the build status
[05:44:50.874] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:50.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:83:0) after 1m0s
[05:45:50.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:83:0)
[05:45:50.933] Timer tick, asking Buildbucket for the build status
[05:45:50.964] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:50.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:84:0) after 1m0s
[05:46:51.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:84:0)
[05:46:51.024] Timer tick, asking Buildbucket for the build status
[05:46:51.097] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:51.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:85:0) after 1m0s
[05:47:51.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:85:0)
[05:47:51.132] Timer tick, asking Buildbucket for the build status
[05:47:51.208] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:51.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:86:0) after 1m0s
[05:48:51.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:86:0)
[05:48:51.233] Timer tick, asking Buildbucket for the build status
[05:48:51.298] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:51.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:87:0) after 1m0s
[05:49:51.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:87:0)
[05:49:51.437] Timer tick, asking Buildbucket for the build status
[05:49:51.495] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:51.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:88:0) after 1m0s
[05:50:51.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:88:0)
[05:50:51.518] Timer tick, asking Buildbucket for the build status
[05:50:51.623] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:51.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:89:0) after 1m0s
[05:51:51.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:89:0)
[05:51:51.697] Timer tick, asking Buildbucket for the build status
[05:51:51.774] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:51.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:90:0) after 1m0s
[05:52:51.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:90:0)
[05:52:51.809] Timer tick, asking Buildbucket for the build status
[05:52:51.864] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:51.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:91:0) after 1m0s
[05:53:51.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:91:0)
[05:53:51.945] Timer tick, asking Buildbucket for the build status
[05:53:51.994] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:51.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:92:0) after 1m0s
[05:54:52.019] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:92:0)
[05:54:52.019] Timer tick, asking Buildbucket for the build status
[05:54:52.113] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:52.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:93:0) after 1m0s
[05:55:52.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:93:0)
[05:55:52.149] Timer tick, asking Buildbucket for the build status
[05:55:52.185] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:52.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:94:0) after 1m0s
[05:56:52.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:94:0)
[05:56:52.215] Timer tick, asking Buildbucket for the build status
[05:56:52.290] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:52.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:95:0) after 1m0s
[05:57:52.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:95:0)
[05:57:52.314] Timer tick, asking Buildbucket for the build status
[05:57:52.380] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:52.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:96:0) after 1m0s
[05:58:52.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:96:0)
[05:58:52.404] Timer tick, asking Buildbucket for the build status
[05:58:52.502] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:52.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:97:0) after 1m0s
[05:59:52.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:97:0)
[05:59:52.527] Timer tick, asking Buildbucket for the build status
[05:59:52.602] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:52.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:98:0) after 1m0s
[06:00:52.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:98:0)
[06:00:52.621] Timer tick, asking Buildbucket for the build status
[06:00:52.685] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:52.685] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:99:0) after 1m0s
[06:01:52.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:99:0)
[06:01:52.731] Timer tick, asking Buildbucket for the build status
[06:01:52.826] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:52.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:100:0) after 1m0s
[06:02:52.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:100:0)
[06:02:52.856] Timer tick, asking Buildbucket for the build status
[06:02:52.891] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:52.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:101:0) after 1m0s
[06:03:52.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:101:0)
[06:03:52.918] Timer tick, asking Buildbucket for the build status
[06:03:53.014] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:53.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:102:0) after 1m0s
[06:04:53.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:102:0)
[06:04:53.037] Timer tick, asking Buildbucket for the build status
[06:04:53.102] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:53.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:103:0) after 1m0s
[06:05:53.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:103:0)
[06:05:53.123] Timer tick, asking Buildbucket for the build status
[06:05:53.188] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:53.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:104:0) after 1m0s
[06:06:53.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:104:0)
[06:06:53.356] Timer tick, asking Buildbucket for the build status
[06:06:53.432] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:53.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:105:0) after 1m0s
[06:07:53.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:105:0)
[06:07:53.455] Timer tick, asking Buildbucket for the build status
[06:07:53.527] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:53.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:106:0) after 1m0s
[06:08:53.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:106:0)
[06:08:53.578] Timer tick, asking Buildbucket for the build status
[06:08:53.643] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:53.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:107:0) after 1m0s
[06:09:53.663] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:107:0)
[06:09:53.663] Timer tick, asking Buildbucket for the build status
[06:09:53.841] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:53.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:108:0) after 1m0s
[06:10:53.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:108:0)
[06:10:53.864] Timer tick, asking Buildbucket for the build status
[06:10:53.944] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:53.945] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:109:0) after 1m0s
[06:11:53.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:109:0)
[06:11:53.970] Timer tick, asking Buildbucket for the build status
[06:11:54.026] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:54.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:110:0) after 1m0s
[06:12:54.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:110:0)
[06:12:54.046] Timer tick, asking Buildbucket for the build status
[06:12:54.207] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:54.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:111:0) after 1m0s
[06:13:54.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:111:0)
[06:13:54.303] Timer tick, asking Buildbucket for the build status
[06:13:54.399] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:54.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:112:0) after 1m0s
[06:14:54.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:112:0)
[06:14:54.419] Timer tick, asking Buildbucket for the build status
[06:14:54.477] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:54.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:113:0) after 1m0s
[06:15:54.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:113:0)
[06:15:54.510] Timer tick, asking Buildbucket for the build status
[06:15:54.567] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:54.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:114:0) after 1m0s
[06:16:54.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:114:0)
[06:16:54.589] Timer tick, asking Buildbucket for the build status
[06:16:54.675] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:54.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:115:0) after 1m0s
[06:17:54.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:115:0)
[06:17:54.695] Timer tick, asking Buildbucket for the build status
[06:17:54.803] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:54.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:116:0) after 1m0s
[06:18:54.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:116:0)
[06:18:54.825] Timer tick, asking Buildbucket for the build status
[06:18:54.889] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:54.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:117:0) after 1m0s
[06:19:54.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:117:0)
[06:19:54.935] Timer tick, asking Buildbucket for the build status
[06:19:55.003] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:55.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:118:0) after 1m0s
[06:20:55.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:118:0)
[06:20:55.022] Timer tick, asking Buildbucket for the build status
[06:20:55.086] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:55.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:119:0) after 1m0s
[06:21:55.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:119:0)
[06:21:55.113] Timer tick, asking Buildbucket for the build status
[06:21:55.184] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:55.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:120:0) after 1m0s
[06:22:55.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:120:0)
[06:22:55.206] Timer tick, asking Buildbucket for the build status
[06:22:55.452] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:55.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:121:0) after 1m0s
[06:23:55.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:121:0)
[06:23:55.473] Timer tick, asking Buildbucket for the build status
[06:23:55.651] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:55.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:122:0) after 1m0s
[06:24:55.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:122:0)
[06:24:55.678] Timer tick, asking Buildbucket for the build status
[06:24:55.751] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:55.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:123:0) after 1m0s
[06:25:55.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:123:0)
[06:25:55.791] Timer tick, asking Buildbucket for the build status
[06:25:55.830] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:55.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:124:0) after 1m0s
[06:26:55.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:124:0)
[06:26:55.849] Timer tick, asking Buildbucket for the build status
[06:26:55.886] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:55.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:125:0) after 1m0s
[06:27:55.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:125:0)
[06:27:55.907] Timer tick, asking Buildbucket for the build status
[06:27:55.962] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:55.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:126:0) after 1m0s
[06:28:55.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:126:0)
[06:28:55.986] Timer tick, asking Buildbucket for the build status
[06:28:56.069] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:56.069] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:127:0) after 1m0s
[06:29:56.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:127:0)
[06:29:56.150] Timer tick, asking Buildbucket for the build status
[06:29:56.357] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:56.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:128:0) after 1m0s
[06:30:56.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:128:0)
[06:30:56.407] Timer tick, asking Buildbucket for the build status
[06:30:56.472] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:56.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:129:0) after 1m0s
[06:31:56.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:129:0)
[06:31:56.515] Timer tick, asking Buildbucket for the build status
[06:31:56.803] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:56.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:130:0) after 1m0s
[06:32:56.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:130:0)
[06:32:56.827] Timer tick, asking Buildbucket for the build status
[06:32:56.906] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:56.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:131:0) after 1m0s
[06:33:56.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:131:0)
[06:33:56.961] Timer tick, asking Buildbucket for the build status
[06:33:57.101] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:57.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:132:0) after 1m0s
[06:34:57.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:132:0)
[06:34:57.131] Timer tick, asking Buildbucket for the build status
[06:34:57.336] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:57.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:133:0) after 1m0s
[06:35:57.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:133:0)
[06:35:57.458] Timer tick, asking Buildbucket for the build status
[06:35:57.528] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:57.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:134:0) after 1m0s
[06:36:57.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:134:0)
[06:36:57.550] Timer tick, asking Buildbucket for the build status
[06:36:57.624] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:57.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:135:0) after 1m0s
[06:37:57.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:135:0)
[06:37:57.649] Timer tick, asking Buildbucket for the build status
[06:37:57.715] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:57.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:136:0) after 1m0s
[06:38:57.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:136:0)
[06:38:57.776] Timer tick, asking Buildbucket for the build status
[06:38:57.842] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:57.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:137:0) after 1m0s
[06:39:57.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:137:0)
[06:39:57.955] Timer tick, asking Buildbucket for the build status
[06:39:58.057] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:58.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:138:0) after 1m0s
[06:40:58.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:138:0)
[06:40:58.144] Timer tick, asking Buildbucket for the build status
[06:40:58.209] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:58.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:139:0) after 1m0s
[06:41:58.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:139:0)
[06:41:58.336] Timer tick, asking Buildbucket for the build status
[06:41:58.406] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:58.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:140:0) after 1m0s
[06:42:58.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:140:0)
[06:42:58.454] Timer tick, asking Buildbucket for the build status
[06:42:58.645] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:58.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:141:0) after 1m0s
[06:43:58.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:141:0)
[06:43:58.690] Timer tick, asking Buildbucket for the build status
[06:43:58.897] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:58.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:142:0) after 1m0s
[06:44:58.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:142:0)
[06:44:58.939] Timer tick, asking Buildbucket for the build status
[06:44:59.005] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:59.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:143:0) after 1m0s
[06:45:59.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:143:0)
[06:45:59.031] Timer tick, asking Buildbucket for the build status
[06:45:59.203] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:59.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:144:0) after 1m0s
[06:46:59.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:144:0)
[06:46:59.227] Timer tick, asking Buildbucket for the build status
[06:46:59.288] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:59.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:145:0) after 1m0s
[06:47:59.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:145:0)
[06:47:59.308] Timer tick, asking Buildbucket for the build status
[06:47:59.373] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:59.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:146:0) after 1m0s
[06:48:59.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:146:0)
[06:48:59.403] Timer tick, asking Buildbucket for the build status
[06:48:59.605] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:59.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:147:0) after 1m0s
[06:49:59.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:147:0)
[06:49:59.626] Timer tick, asking Buildbucket for the build status
[06:49:59.671] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:59.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:148:0) after 1m0s
[06:50:59.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:148:0)
[06:50:59.688] Timer tick, asking Buildbucket for the build status
[06:50:59.810] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:59.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:149:0) after 1m0s
[06:51:59.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:149:0)
[06:51:59.829] Timer tick, asking Buildbucket for the build status
[06:51:59.894] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:59.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:150:0) after 1m0s
[06:52:59.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:150:0)
[06:52:59.939] Timer tick, asking Buildbucket for the build status
[06:53:00.041] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:00.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:151:0) after 1m0s
[06:54:00.100] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:151:0)
[06:54:00.100] Timer tick, asking Buildbucket for the build status
[06:54:00.163] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:00.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:152:0) after 1m0s
[06:55:00.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:152:0)
[06:55:00.309] Timer tick, asking Buildbucket for the build status
[06:55:00.345] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:00.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:153:0) after 1m0s
[06:56:00.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:153:0)
[06:56:00.387] Timer tick, asking Buildbucket for the build status
[06:56:00.496] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:00.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:154:0) after 1m0s
[06:57:00.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:154:0)
[06:57:00.529] Timer tick, asking Buildbucket for the build status
[06:57:00.592] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:00.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:155:0) after 1m0s
[06:58:00.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:155:0)
[06:58:00.612] Timer tick, asking Buildbucket for the build status
[06:58:00.766] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:00.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:156:0) after 1m0s
[06:59:00.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:156:0)
[06:59:00.802] Timer tick, asking Buildbucket for the build status
[06:59:00.944] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:00.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:157:0) after 1m0s
[07:00:00.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:157:0)
[07:00:00.965] Timer tick, asking Buildbucket for the build status
[07:00:01.033] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:01.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:158:0) after 1m0s
[07:01:01.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:158:0)
[07:01:01.063] Timer tick, asking Buildbucket for the build status
[07:01:01.607] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:01.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:159:0) after 1m0s
[07:02:01.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:159:0)
[07:02:01.713] Timer tick, asking Buildbucket for the build status
[07:02:01.759] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:01.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:160:0) after 1m0s
[07:03:01.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:160:0)
[07:03:01.790] Timer tick, asking Buildbucket for the build status
[07:03:01.866] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:01.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:161:0) after 1m0s
[07:04:01.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:161:0)
[07:04:01.892] Timer tick, asking Buildbucket for the build status
[07:04:01.955] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:01.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:162:0) after 1m0s
[07:05:02.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:162:0)
[07:05:02.028] Timer tick, asking Buildbucket for the build status
[07:05:02.357] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:02.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:163:0) after 1m0s
[07:06:02.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:163:0)
[07:06:02.437] Timer tick, asking Buildbucket for the build status
[07:06:02.534] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:02.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:164:0) after 1m0s
[07:07:02.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:164:0)
[07:07:02.571] Timer tick, asking Buildbucket for the build status
[07:07:02.628] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:02.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:165:0) after 1m0s
[07:08:02.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:165:0)
[07:08:02.777] Timer tick, asking Buildbucket for the build status
[07:08:03.067] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:03.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:166:0) after 1m0s
[07:09:03.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:166:0)
[07:09:03.092] Timer tick, asking Buildbucket for the build status
[07:09:03.308] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:03.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:167:0) after 1m0s
[07:10:03.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:167:0)
[07:10:03.331] Timer tick, asking Buildbucket for the build status
[07:10:03.379] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:03.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:168:0) after 1m0s
[07:11:03.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:168:0)
[07:11:03.527] Timer tick, asking Buildbucket for the build status
[07:11:03.653] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:03.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:169:0) after 1m0s
[07:12:03.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:169:0)
[07:12:03.681] Timer tick, asking Buildbucket for the build status
[07:12:04.110] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:04.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:170:0) after 1m0s
[07:13:04.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:170:0)
[07:13:04.194] Timer tick, asking Buildbucket for the build status
[07:13:04.383] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:04.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:171:0) after 1m0s
[07:14:04.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:171:0)
[07:14:04.424] Timer tick, asking Buildbucket for the build status
[07:14:04.496] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:04.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:172:0) after 1m0s
[07:15:04.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:172:0)
[07:15:04.537] Timer tick, asking Buildbucket for the build status
[07:15:04.606] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:04.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:173:0) after 1m0s
[07:16:04.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:173:0)
[07:16:04.696] Timer tick, asking Buildbucket for the build status
[07:16:04.776] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:04.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:174:0) after 1m0s
[07:17:04.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:174:0)
[07:17:04.802] Timer tick, asking Buildbucket for the build status
[07:17:04.875] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:04.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:175:0) after 1m0s
[07:18:04.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:175:0)
[07:18:04.898] Timer tick, asking Buildbucket for the build status
[07:18:04.945] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:04.945] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:176:0) after 1m0s
[07:19:04.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:176:0)
[07:19:04.965] Timer tick, asking Buildbucket for the build status
[07:19:05.029] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:05.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:177:0) after 1m0s
[07:20:05.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:177:0)
[07:20:05.071] Timer tick, asking Buildbucket for the build status
[07:20:05.146] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:05.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:178:0) after 1m0s
[07:21:05.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:178:0)
[07:21:05.173] Timer tick, asking Buildbucket for the build status
[07:21:05.275] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:05.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:179:0) after 1m0s
[07:22:05.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:179:0)
[07:22:05.300] Timer tick, asking Buildbucket for the build status
[07:22:05.425] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:05.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:180:0) after 1m0s
[07:23:05.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:180:0)
[07:23:05.455] Timer tick, asking Buildbucket for the build status
[07:23:05.493] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:05.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:181:0) after 1m0s
[07:24:05.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:181:0)
[07:24:05.516] Timer tick, asking Buildbucket for the build status
[07:24:05.641] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:05.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:182:0) after 1m0s
[07:25:05.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:182:0)
[07:25:05.682] Timer tick, asking Buildbucket for the build status
[07:25:05.811] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:05.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:183:0) after 1m0s
[07:26:05.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:183:0)
[07:26:05.835] Timer tick, asking Buildbucket for the build status
[07:26:06.036] Build 8933626224272350944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:06.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9099056286396270736:184:0) after 1m0s
[07:26:36.147] Received PubSub notification, asking Buildbucket for the build status
[07:26:36.207] Build 8933626224272350944: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[07:26:36.207] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "completed_ts": "1538637995054940",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1538627139746465",
    "failure_reason": "INFRA_FAILURE",
    "id": "8933626224272350944",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"70.0.3538.46\"}}",
    "project": "infra",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"\"}, \"build_run_result\": {\"infraFailure\": {\"text\": \"kitchen crashed or got killed\", \"bootstrapperCallStack\": [], \"type\": \"BOOTSTRAPPER_ERROR\"}, \"recipeResult\": null, \"recipeExitCode\": null, \"recipe\": null, \"annotationUrl\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Build From Tarball\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3801-8761768\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-e833d7b0-us-west1-b-w9dc\"], \"pool\": [\"luci.infra.cron\"], \"caches\": [\"vpython\"]}}, \"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1538627163108828",
    "status": "COMPLETED",
    "status_changed_ts": "1538637995575919",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9099056286396270736",
      "scheduler_job_id:infra/Build From Tarball",
      "swarming_dimension:builder:Build From Tarball",
      "swarming_dimension:caches:builder_99d5fe30e8b6c78ca136ab5e547c67467b176b4f7d67cf49cf682cf48a330f19_v2",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.infra.cron",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:buildbucket_bucket:luci.infra.cron",
      "swarming_tag:buildbucket_build_id:8933626224272350944",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
      "swarming_tag:builder:Build From Tarball",
      "swarming_tag:caches:builder_99d5fe30e8b6c78ca136ab5e547c67467b176b4f7d67cf49cf682cf48a330f19_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8933626224272350944/+/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:9099056286396270736",
      "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:f18910c956967c1117c52a51c48c33e3a3046ca4",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:user_agent:recipe",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:40562482b4d29e10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1538637995577043",
    "url": "https://ci.chromium.org/p/infra/builds/b8933626224272350944",
    "utcnow_ts": "1538637996191110"
  }
}
[07:26:36.207] Invocation finished in 3h0m57.870341538s with status FAILED