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

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

{
  "version": "85.0.4162.3"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[02:02:16.184] New invocation is queued and will start shortly
[02:02:16.184] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[02:02:17.423] Starting the invocation (attempt 1)
[02:02:17.469] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:02:17.469] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:02:17.469] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9043982350855001920",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4162.3\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"7a1285a1-ead0-45ae-ab2e-06c4d87fd388\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4162.3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9043982350855001920",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[02:02:18.071] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1591149737601355",
    "id": "8878552288703999776",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4162.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"7a1285a1-ead0-45ae-ab2e-06c4d87fd388\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4162.3\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1591149737843738",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9043982350855001920",
      "scheduler_job_id:infra/Build From Tarball",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8878552288703999776/+/annotations",
      "swarming_tag:luci_project:infra",
      "swarming_tag:recipe_name:build_from_tarball",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
      "swarming_task_id:",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1591149737843898",
    "url": "https://ci.chromium.org/b/8878552288703999776",
    "utcnow_ts": "1591149738057496"
  }
}
[02:02:18.071] Task URL: https://ci.chromium.org/b/8878552288703999776
[02:02:18.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:2:0) after 1m0s
[02:03:18.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:2:0)
[02:03:18.387] Timer tick, asking Buildbucket for the build status
[02:03:18.525] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:18.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:3:0) after 1m0s
[02:04:18.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:3:0)
[02:04:18.679] Timer tick, asking Buildbucket for the build status
[02:04:18.978] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:18.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:4:0) after 1m0s
[02:05:19.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:4:0)
[02:05:19.066] Timer tick, asking Buildbucket for the build status
[02:05:19.250] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:19.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:5:0) after 1m0s
[02:06:19.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:5:0)
[02:06:19.421] Timer tick, asking Buildbucket for the build status
[02:06:19.815] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:19.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:6:0) after 1m0s
[02:07:19.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:6:0)
[02:07:19.965] Timer tick, asking Buildbucket for the build status
[02:07:20.188] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:20.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:7:0) after 1m0s
[02:08:20.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:7:0)
[02:08:20.386] Timer tick, asking Buildbucket for the build status
[02:08:20.495] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:20.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:8:0) after 1m0s
[02:09:20.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:8:0)
[02:09:20.604] Timer tick, asking Buildbucket for the build status
[02:09:20.730] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:20.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:9:0) after 1m0s
[02:10:20.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:9:0)
[02:10:20.921] Timer tick, asking Buildbucket for the build status
[02:10:21.324] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:21.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:10:0) after 1m0s
[02:11:21.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:10:0)
[02:11:21.525] Timer tick, asking Buildbucket for the build status
[02:11:23.454] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:23.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:11:0) after 1m0s
[02:12:23.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:11:0)
[02:12:23.710] Timer tick, asking Buildbucket for the build status
[02:12:23.824] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:23.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:12:0) after 1m0s
[02:13:24.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:12:0)
[02:13:24.133] Timer tick, asking Buildbucket for the build status
[02:13:24.425] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:24.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:13:0) after 1m0s
[02:14:24.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:13:0)
[02:14:24.533] Timer tick, asking Buildbucket for the build status
[02:14:24.657] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:24.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:14:0) after 1m0s
[02:15:24.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:14:0)
[02:15:24.955] Timer tick, asking Buildbucket for the build status
[02:15:25.313] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:25.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:15:0) after 1m0s
[02:16:25.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:15:0)
[02:16:25.545] Timer tick, asking Buildbucket for the build status
[02:16:26.769] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:26.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:16:0) after 1m0s
[02:17:27.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:16:0)
[02:17:27.153] Timer tick, asking Buildbucket for the build status
[02:17:27.666] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:27.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:17:0) after 1m0s
[02:18:27.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:17:0)
[02:18:27.820] Timer tick, asking Buildbucket for the build status
[02:18:28.028] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:28.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:18:0) after 1m0s
[02:19:28.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:18:0)
[02:19:28.371] Timer tick, asking Buildbucket for the build status
[02:19:28.506] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:28.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:19:0) after 1m0s
[02:20:28.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:19:0)
[02:20:28.653] Timer tick, asking Buildbucket for the build status
[02:20:28.979] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:28.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:20:0) after 1m0s
[02:21:29.171] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:20:0)
[02:21:29.171] Timer tick, asking Buildbucket for the build status
[02:21:29.613] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:29.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:21:0) after 1m0s
[02:22:29.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:21:0)
[02:22:29.636] Timer tick, asking Buildbucket for the build status
[02:22:30.062] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:30.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:22:0) after 1m0s
[02:23:30.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:22:0)
[02:23:30.197] Timer tick, asking Buildbucket for the build status
[02:23:31.088] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:31.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:23:0) after 1m0s
[02:24:31.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:23:0)
[02:24:31.162] Timer tick, asking Buildbucket for the build status
[02:24:31.335] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:31.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:24:0) after 1m0s
[02:25:31.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:24:0)
[02:25:31.433] Timer tick, asking Buildbucket for the build status
[02:25:31.612] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:31.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:25:0) after 1m0s
[02:26:31.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:25:0)
[02:26:31.645] Timer tick, asking Buildbucket for the build status
[02:26:31.910] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:31.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:26:0) after 1m0s
[02:27:31.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:26:0)
[02:27:31.957] Timer tick, asking Buildbucket for the build status
[02:27:32.325] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:32.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:27:0) after 1m0s
[02:28:32.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:27:0)
[02:28:32.336] Timer tick, asking Buildbucket for the build status
[02:28:32.883] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:32.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:28:0) after 1m0s
[02:29:32.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:28:0)
[02:29:32.967] Timer tick, asking Buildbucket for the build status
[02:29:33.227] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:33.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:29:0) after 1m0s
[02:30:33.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:29:0)
[02:30:33.341] Timer tick, asking Buildbucket for the build status
[02:30:33.658] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:33.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:30:0) after 1m0s
[02:31:33.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:30:0)
[02:31:33.702] Timer tick, asking Buildbucket for the build status
[02:31:33.797] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:33.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:31:0) after 1m0s
[02:32:33.844] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:31:0)
[02:32:33.844] Timer tick, asking Buildbucket for the build status
[02:32:34.059] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:34.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:32:0) after 1m0s
[02:33:34.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:32:0)
[02:33:34.128] Timer tick, asking Buildbucket for the build status
[02:33:34.599] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:34.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:33:0) after 1m0s
[02:34:34.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:33:0)
[02:34:34.625] Timer tick, asking Buildbucket for the build status
[02:34:34.827] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:34.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:34:0) after 1m0s
[02:35:34.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:34:0)
[02:35:34.860] Timer tick, asking Buildbucket for the build status
[02:35:35.303] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:35.303] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:35:0) after 1m0s
[02:36:35.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:35:0)
[02:36:35.294] Timer tick, asking Buildbucket for the build status
[02:36:35.516] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:35.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:36:0) after 1m0s
[02:37:35.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:36:0)
[02:37:35.538] Timer tick, asking Buildbucket for the build status
[02:37:35.998] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:35.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:37:0) after 1m0s
[02:38:36.136] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:37:0)
[02:38:36.136] Timer tick, asking Buildbucket for the build status
[02:38:36.500] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:36.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:38:0) after 1m0s
[02:39:36.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:38:0)
[02:39:36.557] Timer tick, asking Buildbucket for the build status
[02:39:36.711] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:36.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:39:0) after 1m0s
[02:40:36.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:39:0)
[02:40:36.783] Timer tick, asking Buildbucket for the build status
[02:40:36.912] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:36.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:40:0) after 1m0s
[02:41:36.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:40:0)
[02:41:36.967] Timer tick, asking Buildbucket for the build status
[02:41:37.256] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:37.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:41:0) after 1m0s
[02:42:37.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:41:0)
[02:42:37.288] Timer tick, asking Buildbucket for the build status
[02:42:37.464] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:37.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:42:0) after 1m0s
[02:43:37.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:42:0)
[02:43:37.495] Timer tick, asking Buildbucket for the build status
[02:43:38.271] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:38.271] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:43:0) after 1m0s
[02:44:38.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:43:0)
[02:44:38.301] Timer tick, asking Buildbucket for the build status
[02:44:38.683] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:38.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:44:0) after 1m0s
[02:45:38.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:44:0)
[02:45:38.707] Timer tick, asking Buildbucket for the build status
[02:45:38.918] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:38.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:45:0) after 1m0s
[02:46:38.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:45:0)
[02:46:38.958] Timer tick, asking Buildbucket for the build status
[02:46:39.317] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:39.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:46:0) after 1m0s
[02:47:39.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:46:0)
[02:47:39.421] Timer tick, asking Buildbucket for the build status
[02:47:39.591] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:39.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:47:0) after 1m0s
[02:48:39.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:47:0)
[02:48:39.656] Timer tick, asking Buildbucket for the build status
[02:48:39.875] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:39.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:48:0) after 1m0s
[02:49:39.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:48:0)
[02:49:39.904] Timer tick, asking Buildbucket for the build status
[02:49:40.235] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:40.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:49:0) after 1m0s
[02:50:40.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:49:0)
[02:50:40.292] Timer tick, asking Buildbucket for the build status
[02:50:40.475] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:40.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:50:0) after 1m0s
[02:51:40.501] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:50:0)
[02:51:40.502] Timer tick, asking Buildbucket for the build status
[02:51:40.625] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:40.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:51:0) after 1m0s
[02:52:40.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:51:0)
[02:52:40.714] Timer tick, asking Buildbucket for the build status
[02:52:40.941] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:40.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:52:0) after 1m0s
[02:53:41.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:52:0)
[02:53:41.023] Timer tick, asking Buildbucket for the build status
[02:53:41.179] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:53:41.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:53:0) after 1m0s
[02:54:41.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:53:0)
[02:54:41.241] Timer tick, asking Buildbucket for the build status
[02:54:41.610] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:54:41.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:54:0) after 1m0s
[02:55:41.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:54:0)
[02:55:41.748] Timer tick, asking Buildbucket for the build status
[02:55:42.203] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:55:42.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:55:0) after 1m0s
[02:56:42.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:55:0)
[02:56:42.251] Timer tick, asking Buildbucket for the build status
[02:56:42.419] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:56:42.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:56:0) after 1m0s
[02:57:42.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:56:0)
[02:57:42.553] Timer tick, asking Buildbucket for the build status
[02:57:43.064] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:57:43.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:57:0) after 1m0s
[02:58:43.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:57:0)
[02:58:43.173] Timer tick, asking Buildbucket for the build status
[02:58:43.327] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:58:43.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:58:0) after 1m0s
[02:59:43.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:58:0)
[02:59:43.376] Timer tick, asking Buildbucket for the build status
[02:59:43.564] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:59:43.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:59:0) after 1m0s
[03:00:43.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:59:0)
[03:00:43.750] Timer tick, asking Buildbucket for the build status
[03:00:44.187] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:00:44.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:60:0) after 1m0s
[03:01:44.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:60:0)
[03:01:44.294] Timer tick, asking Buildbucket for the build status
[03:01:44.461] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:44.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:61:0) after 1m0s
[03:02:44.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:61:0)
[03:02:44.613] Timer tick, asking Buildbucket for the build status
[03:02:47.113] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:47.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:62:0) after 1m0s
[03:03:47.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:62:0)
[03:03:47.183] Timer tick, asking Buildbucket for the build status
[03:03:47.391] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:03:47.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:63:0) after 1m0s
[03:04:47.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:63:0)
[03:04:47.405] Timer tick, asking Buildbucket for the build status
[03:04:47.502] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:04:47.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:64:0) after 1m0s
[03:05:47.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:64:0)
[03:05:47.525] Timer tick, asking Buildbucket for the build status
[03:05:47.951] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:05:47.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:65:0) after 1m0s
[03:06:47.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:65:0)
[03:06:47.970] Timer tick, asking Buildbucket for the build status
[03:06:48.360] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:06:48.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:66:0) after 1m0s
[03:07:48.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:66:0)
[03:07:48.426] Timer tick, asking Buildbucket for the build status
[03:07:48.871] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:07:48.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:67:0) after 1m0s
[03:08:48.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:67:0)
[03:08:48.927] Timer tick, asking Buildbucket for the build status
[03:08:49.396] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:08:49.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:68:0) after 1m0s
[03:09:49.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:68:0)
[03:09:49.434] Timer tick, asking Buildbucket for the build status
[03:09:49.606] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:09:49.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:69:0) after 1m0s
[03:10:49.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:69:0)
[03:10:49.702] Timer tick, asking Buildbucket for the build status
[03:10:50.067] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:10:50.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:70:0) after 1m0s
[03:11:50.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:70:0)
[03:11:50.103] Timer tick, asking Buildbucket for the build status
[03:11:50.298] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:11:50.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:71:0) after 1m0s
[03:12:50.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:71:0)
[03:12:50.298] Timer tick, asking Buildbucket for the build status
[03:12:50.452] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:12:50.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:72:0) after 1m0s
[03:13:50.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:72:0)
[03:13:50.555] Timer tick, asking Buildbucket for the build status
[03:13:50.678] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:13:50.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:73:0) after 1m0s
[03:14:50.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:73:0)
[03:14:50.827] Timer tick, asking Buildbucket for the build status
[03:14:51.012] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:14:51.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:74:0) after 1m0s
[03:15:51.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:74:0)
[03:15:51.169] Timer tick, asking Buildbucket for the build status
[03:15:51.380] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:15:51.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:75:0) after 1m0s
[03:16:51.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:75:0)
[03:16:51.520] Timer tick, asking Buildbucket for the build status
[03:16:51.949] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:16:51.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:76:0) after 1m0s
[03:17:51.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:76:0)
[03:17:51.960] Timer tick, asking Buildbucket for the build status
[03:17:52.905] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:17:52.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:77:0) after 1m0s
[03:18:52.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:77:0)
[03:18:52.939] Timer tick, asking Buildbucket for the build status
[03:18:53.106] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:18:53.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:78:0) after 1m0s
[03:19:53.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:78:0)
[03:19:53.139] Timer tick, asking Buildbucket for the build status
[03:19:53.236] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:19:53.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:79:0) after 1m0s
[03:20:53.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:79:0)
[03:20:53.303] Timer tick, asking Buildbucket for the build status
[03:20:53.594] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:20:53.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:80:0) after 1m0s
[03:21:53.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:80:0)
[03:21:53.651] Timer tick, asking Buildbucket for the build status
[03:21:53.817] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:21:53.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:81:0) after 1m0s
[03:22:53.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:81:0)
[03:22:53.882] Timer tick, asking Buildbucket for the build status
[03:22:54.085] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:22:54.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:82:0) after 1m0s
[03:23:54.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:82:0)
[03:23:54.202] Timer tick, asking Buildbucket for the build status
[03:23:54.549] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:23:54.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:83:0) after 1m0s
[03:24:55.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:83:0)
[03:24:55.126] Timer tick, asking Buildbucket for the build status
[03:24:55.372] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:24:55.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:84:0) after 1m0s
[03:25:55.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:84:0)
[03:25:55.383] Timer tick, asking Buildbucket for the build status
[03:25:55.529] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:25:55.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:85:0) after 1m0s
[03:26:55.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:85:0)
[03:26:55.562] Timer tick, asking Buildbucket for the build status
[03:26:55.666] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:26:55.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:86:0) after 1m0s
[03:27:55.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:86:0)
[03:27:55.843] Timer tick, asking Buildbucket for the build status
[03:27:56.004] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:27:56.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:87:0) after 1m0s
[03:28:56.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:87:0)
[03:28:56.033] Timer tick, asking Buildbucket for the build status
[03:28:56.191] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:28:56.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:88:0) after 1m0s
[03:29:56.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:88:0)
[03:29:56.235] Timer tick, asking Buildbucket for the build status
[03:29:56.351] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:29:56.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:89:0) after 1m0s
[03:30:56.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:89:0)
[03:30:56.394] Timer tick, asking Buildbucket for the build status
[03:30:56.509] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:30:56.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:90:0) after 1m0s
[03:31:56.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:90:0)
[03:31:56.523] Timer tick, asking Buildbucket for the build status
[03:31:56.681] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:31:56.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:91:0) after 1m0s
[03:32:56.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:91:0)
[03:32:56.800] Timer tick, asking Buildbucket for the build status
[03:32:56.991] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:32:56.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:92:0) after 1m0s
[03:33:57.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:92:0)
[03:33:57.126] Timer tick, asking Buildbucket for the build status
[03:33:57.318] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:33:57.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:93:0) after 1m0s
[03:34:57.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:93:0)
[03:34:57.400] Timer tick, asking Buildbucket for the build status
[03:34:57.840] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:34:57.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:94:0) after 1m0s
[03:35:57.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:94:0)
[03:35:57.873] Timer tick, asking Buildbucket for the build status
[03:35:58.008] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:35:58.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:95:0) after 1m0s
[03:36:58.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:95:0)
[03:36:58.111] Timer tick, asking Buildbucket for the build status
[03:36:58.352] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:36:58.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:96:0) after 1m0s
[03:37:58.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:96:0)
[03:37:58.472] Timer tick, asking Buildbucket for the build status
[03:37:58.850] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:37:58.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:97:0) after 1m0s
[03:38:58.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:97:0)
[03:38:58.905] Timer tick, asking Buildbucket for the build status
[03:38:59.036] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:38:59.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:98:0) after 1m0s
[03:39:59.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:98:0)
[03:39:59.242] Timer tick, asking Buildbucket for the build status
[03:39:59.796] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:39:59.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:99:0) after 1m0s
[03:40:59.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:99:0)
[03:40:59.875] Timer tick, asking Buildbucket for the build status
[03:41:00.215] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:41:00.215] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:100:0) after 1m0s
[03:42:00.399] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:100:0)
[03:42:00.399] Timer tick, asking Buildbucket for the build status
[03:42:00.542] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:42:00.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:101:0) after 1m0s
[03:43:00.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:101:0)
[03:43:00.587] Timer tick, asking Buildbucket for the build status
[03:43:00.761] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:43:00.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:102:0) after 1m0s
[03:44:01.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:102:0)
[03:44:01.336] Timer tick, asking Buildbucket for the build status
[03:44:01.487] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:44:01.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:103:0) after 1m0s
[03:45:01.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:103:0)
[03:45:01.935] Timer tick, asking Buildbucket for the build status
[03:45:02.119] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:45:02.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:104:0) after 1m0s
[03:46:02.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:104:0)
[03:46:02.124] Timer tick, asking Buildbucket for the build status
[03:46:02.251] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:46:02.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:105:0) after 1m0s
[03:47:02.300] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:105:0)
[03:47:02.300] Timer tick, asking Buildbucket for the build status
[03:47:02.774] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:47:02.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:106:0) after 1m0s
[03:48:02.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:106:0)
[03:48:02.878] Timer tick, asking Buildbucket for the build status
[03:48:03.001] Build 8878552288703999776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:48:03.001] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:107:0) after 1m0s
[03:48:36.409] Received PubSub notification, asking Buildbucket for the build status
[03:48:36.602] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:03.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:107:0)
[03:49:03.014] Timer tick, asking Buildbucket for the build status
[03:49:03.192] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:03.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:109:0) after 1m0s
[03:50:03.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:109:0)
[03:50:03.285] Timer tick, asking Buildbucket for the build status
[03:50:03.450] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:03.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:110:0) after 1m0s
[03:51:03.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:110:0)
[03:51:03.500] Timer tick, asking Buildbucket for the build status
[03:51:03.651] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:03.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:111:0) after 1m0s
[03:52:03.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:111:0)
[03:52:03.766] Timer tick, asking Buildbucket for the build status
[03:52:03.928] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:03.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:112:0) after 1m0s
[03:53:03.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:112:0)
[03:53:03.956] Timer tick, asking Buildbucket for the build status
[03:53:04.328] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:04.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:113:0) after 1m0s
[03:54:04.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:113:0)
[03:54:04.379] Timer tick, asking Buildbucket for the build status
[03:54:04.534] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:04.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:114:0) after 1m0s
[03:55:04.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:114:0)
[03:55:04.557] Timer tick, asking Buildbucket for the build status
[03:55:04.856] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:04.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:115:0) after 1m0s
[03:56:04.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:115:0)
[03:56:04.916] Timer tick, asking Buildbucket for the build status
[03:56:05.064] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:05.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:116:0) after 1m0s
[03:57:05.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:116:0)
[03:57:05.126] Timer tick, asking Buildbucket for the build status
[03:57:05.296] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:05.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:117:0) after 1m0s
[03:58:05.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:117:0)
[03:58:05.364] Timer tick, asking Buildbucket for the build status
[03:58:05.779] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:05.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:118:0) after 1m0s
[03:59:05.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:118:0)
[03:59:05.815] Timer tick, asking Buildbucket for the build status
[03:59:06.105] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:06.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:119:0) after 1m0s
[04:00:06.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:119:0)
[04:00:06.196] Timer tick, asking Buildbucket for the build status
[04:00:06.410] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:06.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:120:0) after 1m0s
[04:01:06.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:120:0)
[04:01:06.447] Timer tick, asking Buildbucket for the build status
[04:01:06.651] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:06.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:121:0) after 1m0s
[04:02:06.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:121:0)
[04:02:06.715] Timer tick, asking Buildbucket for the build status
[04:02:07.239] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:07.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:122:0) after 1m0s
[04:03:07.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:122:0)
[04:03:07.324] Timer tick, asking Buildbucket for the build status
[04:03:07.678] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:07.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:123:0) after 1m0s
[04:04:07.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:123:0)
[04:04:07.727] Timer tick, asking Buildbucket for the build status
[04:04:08.560] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:08.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:124:0) after 1m0s
[04:05:08.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:124:0)
[04:05:08.642] Timer tick, asking Buildbucket for the build status
[04:05:08.879] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:08.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:125:0) after 1m0s
[04:06:08.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:125:0)
[04:06:08.902] Timer tick, asking Buildbucket for the build status
[04:06:09.049] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:09.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:126:0) after 1m0s
[04:07:09.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:126:0)
[04:07:09.095] Timer tick, asking Buildbucket for the build status
[04:07:09.272] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:09.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:127:0) after 1m0s
[04:08:09.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:127:0)
[04:08:09.294] Timer tick, asking Buildbucket for the build status
[04:08:09.458] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:09.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:128:0) after 1m0s
[04:09:09.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:128:0)
[04:09:09.488] Timer tick, asking Buildbucket for the build status
[04:09:09.990] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:09.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:129:0) after 1m0s
[04:10:10.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:129:0)
[04:10:10.016] Timer tick, asking Buildbucket for the build status
[04:10:10.877] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:10.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:130:0) after 1m0s
[04:11:10.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:130:0)
[04:11:10.882] Timer tick, asking Buildbucket for the build status
[04:11:11.438] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:11.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:131:0) after 1m0s
[04:12:11.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:131:0)
[04:12:11.542] Timer tick, asking Buildbucket for the build status
[04:12:11.678] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:11.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:132:0) after 1m0s
[04:13:11.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:132:0)
[04:13:11.673] Timer tick, asking Buildbucket for the build status
[04:13:11.833] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:11.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:133:0) after 1m0s
[04:14:11.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:133:0)
[04:14:11.856] Timer tick, asking Buildbucket for the build status
[04:14:12.104] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:12.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:134:0) after 1m0s
[04:15:12.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:134:0)
[04:15:12.178] Timer tick, asking Buildbucket for the build status
[04:15:12.490] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:12.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:135:0) after 1m0s
[04:16:12.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:135:0)
[04:16:12.536] Timer tick, asking Buildbucket for the build status
[04:16:12.749] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:12.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:136:0) after 1m0s
[04:17:12.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:136:0)
[04:17:12.817] Timer tick, asking Buildbucket for the build status
[04:17:13.181] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:13.181] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:137:0) after 1m0s
[04:18:13.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:137:0)
[04:18:13.290] Timer tick, asking Buildbucket for the build status
[04:18:13.452] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:13.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:138:0) after 1m0s
[04:19:13.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:138:0)
[04:19:13.535] Timer tick, asking Buildbucket for the build status
[04:19:13.755] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:13.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:139:0) after 1m0s
[04:20:13.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:139:0)
[04:20:13.794] Timer tick, asking Buildbucket for the build status
[04:20:14.252] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:14.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:140:0) after 1m0s
[04:21:14.280] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:140:0)
[04:21:14.280] Timer tick, asking Buildbucket for the build status
[04:21:14.652] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:14.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:141:0) after 1m0s
[04:22:14.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:141:0)
[04:22:14.676] Timer tick, asking Buildbucket for the build status
[04:22:15.258] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:15.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:142:0) after 1m0s
[04:23:15.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:142:0)
[04:23:15.313] Timer tick, asking Buildbucket for the build status
[04:23:15.490] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:15.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:143:0) after 1m0s
[04:24:15.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:143:0)
[04:24:15.516] Timer tick, asking Buildbucket for the build status
[04:24:15.961] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:15.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:144:0) after 1m0s
[04:25:15.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:144:0)
[04:25:15.991] Timer tick, asking Buildbucket for the build status
[04:25:16.463] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:16.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:145:0) after 1m0s
[04:26:16.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:145:0)
[04:26:16.522] Timer tick, asking Buildbucket for the build status
[04:26:16.827] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:16.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:146:0) after 1m0s
[04:27:16.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:146:0)
[04:27:16.969] Timer tick, asking Buildbucket for the build status
[04:27:17.390] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:17.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:147:0) after 1m0s
[04:28:17.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:147:0)
[04:28:17.608] Timer tick, asking Buildbucket for the build status
[04:28:17.776] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:17.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:148:0) after 1m0s
[04:29:17.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:148:0)
[04:29:17.876] Timer tick, asking Buildbucket for the build status
[04:29:18.023] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:18.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:149:0) after 1m0s
[04:30:18.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:149:0)
[04:30:18.074] Timer tick, asking Buildbucket for the build status
[04:30:19.265] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:19.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:150:0) after 1m0s
[04:31:19.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:150:0)
[04:31:19.352] Timer tick, asking Buildbucket for the build status
[04:31:19.500] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:19.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:151:0) after 1m0s
[04:32:19.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:151:0)
[04:32:19.573] Timer tick, asking Buildbucket for the build status
[04:32:19.987] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:19.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:152:0) after 1m0s
[04:33:20.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:152:0)
[04:33:20.099] Timer tick, asking Buildbucket for the build status
[04:33:20.465] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:20.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:153:0) after 1m0s
[04:34:20.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:153:0)
[04:34:20.525] Timer tick, asking Buildbucket for the build status
[04:34:20.656] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:20.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:154:0) after 1m0s
[04:35:20.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:154:0)
[04:35:20.763] Timer tick, asking Buildbucket for the build status
[04:35:21.019] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:21.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:155:0) after 1m0s
[04:36:21.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:155:0)
[04:36:21.098] Timer tick, asking Buildbucket for the build status
[04:36:21.280] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:21.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:156:0) after 1m0s
[04:37:21.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:156:0)
[04:37:21.304] Timer tick, asking Buildbucket for the build status
[04:37:21.455] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:21.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:157:0) after 1m0s
[04:38:21.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:157:0)
[04:38:21.493] Timer tick, asking Buildbucket for the build status
[04:38:21.672] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:21.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:158:0) after 1m0s
[04:39:21.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:158:0)
[04:39:21.669] Timer tick, asking Buildbucket for the build status
[04:39:22.745] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:22.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:159:0) after 1m0s
[04:40:22.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:159:0)
[04:40:22.860] Timer tick, asking Buildbucket for the build status
[04:40:22.978] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:22.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:160:0) after 1m0s
[04:41:23.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:160:0)
[04:41:23.029] Timer tick, asking Buildbucket for the build status
[04:41:23.701] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:23.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:161:0) after 1m0s
[04:42:23.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:161:0)
[04:42:23.789] Timer tick, asking Buildbucket for the build status
[04:42:24.019] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:24.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:162:0) after 1m0s
[04:43:24.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:162:0)
[04:43:24.112] Timer tick, asking Buildbucket for the build status
[04:43:24.300] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:24.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:163:0) after 1m0s
[04:44:24.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:163:0)
[04:44:24.516] Timer tick, asking Buildbucket for the build status
[04:44:24.715] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:24.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:164:0) after 1m0s
[04:45:24.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:164:0)
[04:45:24.925] Timer tick, asking Buildbucket for the build status
[04:45:25.467] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:25.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:165:0) after 1m0s
[04:46:25.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:165:0)
[04:46:25.605] Timer tick, asking Buildbucket for the build status
[04:46:25.945] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:25.945] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:166:0) after 1m0s
[04:47:26.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:166:0)
[04:47:26.042] Timer tick, asking Buildbucket for the build status
[04:47:26.217] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:26.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:167:0) after 1m0s
[04:48:26.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:167:0)
[04:48:26.251] Timer tick, asking Buildbucket for the build status
[04:48:26.377] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:26.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:168:0) after 1m0s
[04:49:26.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:168:0)
[04:49:26.408] Timer tick, asking Buildbucket for the build status
[04:49:26.532] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:26.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:169:0) after 1m0s
[04:50:26.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:169:0)
[04:50:26.575] Timer tick, asking Buildbucket for the build status
[04:50:26.912] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:26.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:170:0) after 1m0s
[04:51:26.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:170:0)
[04:51:26.951] Timer tick, asking Buildbucket for the build status
[04:51:27.280] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:27.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:171:0) after 1m0s
[04:52:27.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:171:0)
[04:52:27.316] Timer tick, asking Buildbucket for the build status
[04:52:27.493] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:27.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:172:0) after 1m0s
[04:53:27.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:172:0)
[04:53:27.550] Timer tick, asking Buildbucket for the build status
[04:53:27.808] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:27.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:173:0) after 1m0s
[04:54:27.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:173:0)
[04:54:27.932] Timer tick, asking Buildbucket for the build status
[04:54:28.206] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:28.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:174:0) after 1m0s
[04:55:28.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:174:0)
[04:55:28.254] Timer tick, asking Buildbucket for the build status
[04:55:28.398] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:28.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:175:0) after 1m0s
[04:56:28.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:175:0)
[04:56:28.437] Timer tick, asking Buildbucket for the build status
[04:56:30.032] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:30.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:176:0) after 1m0s
[04:57:30.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:176:0)
[04:57:30.062] Timer tick, asking Buildbucket for the build status
[04:57:31.355] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:31.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:177:0) after 1m0s
[04:58:31.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:177:0)
[04:58:31.410] Timer tick, asking Buildbucket for the build status
[04:58:31.811] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:31.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:178:0) after 1m0s
[04:59:31.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:178:0)
[04:59:31.858] Timer tick, asking Buildbucket for the build status
[04:59:32.282] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:32.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:179:0) after 1m0s
[05:00:32.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:179:0)
[05:00:32.346] Timer tick, asking Buildbucket for the build status
[05:00:32.539] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:32.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:180:0) after 1m0s
[05:01:32.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:180:0)
[05:01:32.643] Timer tick, asking Buildbucket for the build status
[05:01:32.798] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:32.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:181:0) after 1m0s
[05:02:32.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:181:0)
[05:02:32.825] Timer tick, asking Buildbucket for the build status
[05:02:34.895] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:34.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:182:0) after 1m0s
[05:03:34.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:182:0)
[05:03:34.904] Timer tick, asking Buildbucket for the build status
[05:03:35.268] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:35.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:183:0) after 1m0s
[05:04:35.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:183:0)
[05:04:35.368] Timer tick, asking Buildbucket for the build status
[05:04:35.512] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:35.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:184:0) after 1m0s
[05:05:35.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:184:0)
[05:05:35.558] Timer tick, asking Buildbucket for the build status
[05:05:36.385] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:36.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:185:0) after 1m0s
[05:06:36.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:185:0)
[05:06:36.431] Timer tick, asking Buildbucket for the build status
[05:06:36.561] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:36.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:186:0) after 1m0s
[05:07:36.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:186:0)
[05:07:36.594] Timer tick, asking Buildbucket for the build status
[05:07:36.809] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:36.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:187:0) after 1m0s
[05:08:36.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:187:0)
[05:08:36.830] Timer tick, asking Buildbucket for the build status
[05:08:37.053] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:37.053] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:188:0) after 1m0s
[05:09:37.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:188:0)
[05:09:37.089] Timer tick, asking Buildbucket for the build status
[05:09:37.342] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:37.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:189:0) after 1m0s
[05:10:37.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:189:0)
[05:10:37.378] Timer tick, asking Buildbucket for the build status
[05:10:37.911] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:37.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:190:0) after 1m0s
[05:11:38.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:190:0)
[05:11:38.153] Timer tick, asking Buildbucket for the build status
[05:11:38.301] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:38.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:191:0) after 1m0s
[05:12:38.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:191:0)
[05:12:38.554] Timer tick, asking Buildbucket for the build status
[05:12:38.881] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:38.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:192:0) after 1m0s
[05:13:38.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:192:0)
[05:13:38.966] Timer tick, asking Buildbucket for the build status
[05:13:39.142] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:39.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:193:0) after 1m0s
[05:14:39.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:193:0)
[05:14:39.204] Timer tick, asking Buildbucket for the build status
[05:14:40.153] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:40.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:194:0) after 1m0s
[05:15:40.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:194:0)
[05:15:40.231] Timer tick, asking Buildbucket for the build status
[05:15:40.378] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:40.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:195:0) after 1m0s
[05:16:40.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:195:0)
[05:16:40.529] Timer tick, asking Buildbucket for the build status
[05:16:41.487] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:41.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:196:0) after 1m0s
[05:17:41.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:196:0)
[05:17:41.682] Timer tick, asking Buildbucket for the build status
[05:17:41.856] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:41.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:197:0) after 1m0s
[05:18:41.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:197:0)
[05:18:41.961] Timer tick, asking Buildbucket for the build status
[05:18:42.134] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:42.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:198:0) after 1m0s
[05:19:42.140] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:198:0)
[05:19:42.140] Timer tick, asking Buildbucket for the build status
[05:19:42.266] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:42.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:199:0) after 1m0s
[05:20:42.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:199:0)
[05:20:42.297] Timer tick, asking Buildbucket for the build status
[05:20:42.844] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:42.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:200:0) after 1m0s
[05:21:42.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:200:0)
[05:21:42.914] Timer tick, asking Buildbucket for the build status
[05:21:43.072] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:43.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:201:0) after 1m0s
[05:22:43.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:201:0)
[05:22:43.146] Timer tick, asking Buildbucket for the build status
[05:22:43.421] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:43.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:202:0) after 1m0s
[05:23:43.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:202:0)
[05:23:43.586] Timer tick, asking Buildbucket for the build status
[05:23:43.765] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:43.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:203:0) after 1m0s
[05:24:43.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:203:0)
[05:24:43.829] Timer tick, asking Buildbucket for the build status
[05:24:43.949] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:43.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:204:0) after 1m0s
[05:25:44.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:204:0)
[05:25:44.017] Timer tick, asking Buildbucket for the build status
[05:25:44.337] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:44.337] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:205:0) after 1m0s
[05:26:44.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:205:0)
[05:26:44.432] Timer tick, asking Buildbucket for the build status
[05:26:44.718] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:44.718] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:206:0) after 1m0s
[05:27:44.772] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:206:0)
[05:27:44.772] Timer tick, asking Buildbucket for the build status
[05:27:44.908] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:44.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:207:0) after 1m0s
[05:28:45.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:207:0)
[05:28:45.055] Timer tick, asking Buildbucket for the build status
[05:28:45.677] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:45.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:208:0) after 1m0s
[05:29:45.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:208:0)
[05:29:45.707] Timer tick, asking Buildbucket for the build status
[05:29:45.845] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:45.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:209:0) after 1m0s
[05:30:45.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:209:0)
[05:30:45.877] Timer tick, asking Buildbucket for the build status
[05:30:46.066] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:46.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:210:0) after 1m0s
[05:31:46.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:210:0)
[05:31:46.166] Timer tick, asking Buildbucket for the build status
[05:31:46.332] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:46.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:211:0) after 1m0s
[05:32:46.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:211:0)
[05:32:46.375] Timer tick, asking Buildbucket for the build status
[05:32:46.582] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:46.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:212:0) after 1m0s
[05:33:46.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:212:0)
[05:33:46.650] Timer tick, asking Buildbucket for the build status
[05:33:47.634] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:47.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:213:0) after 1m0s
[05:34:47.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:213:0)
[05:34:47.736] Timer tick, asking Buildbucket for the build status
[05:34:47.858] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:47.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:214:0) after 1m0s
[05:35:47.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:214:0)
[05:35:47.973] Timer tick, asking Buildbucket for the build status
[05:35:48.110] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:48.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:215:0) after 1m0s
[05:36:48.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:215:0)
[05:36:48.246] Timer tick, asking Buildbucket for the build status
[05:36:48.546] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:48.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:216:0) after 1m0s
[05:37:48.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:216:0)
[05:37:48.622] Timer tick, asking Buildbucket for the build status
[05:37:48.838] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:48.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:217:0) after 1m0s
[05:38:48.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:217:0)
[05:38:48.940] Timer tick, asking Buildbucket for the build status
[05:38:49.798] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:49.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:218:0) after 1m0s
[05:39:49.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:218:0)
[05:39:49.814] Timer tick, asking Buildbucket for the build status
[05:39:50.006] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:50.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:219:0) after 1m0s
[05:40:50.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:219:0)
[05:40:50.094] Timer tick, asking Buildbucket for the build status
[05:40:50.235] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:50.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:220:0) after 1m0s
[05:41:50.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:220:0)
[05:41:50.370] Timer tick, asking Buildbucket for the build status
[05:41:50.618] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:50.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:221:0) after 1m0s
[05:42:50.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:221:0)
[05:42:50.791] Timer tick, asking Buildbucket for the build status
[05:42:51.302] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:51.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:222:0) after 1m0s
[05:43:51.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:222:0)
[05:43:51.400] Timer tick, asking Buildbucket for the build status
[05:43:51.617] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:51.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:223:0) after 1m0s
[05:44:51.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:223:0)
[05:44:51.709] Timer tick, asking Buildbucket for the build status
[05:44:51.955] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:51.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:224:0) after 1m0s
[05:45:52.072] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:224:0)
[05:45:52.072] Timer tick, asking Buildbucket for the build status
[05:45:52.255] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:52.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:225:0) after 1m0s
[05:46:52.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:225:0)
[05:46:52.335] Timer tick, asking Buildbucket for the build status
[05:46:52.486] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:52.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:226:0) after 1m0s
[05:47:52.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:226:0)
[05:47:52.600] Timer tick, asking Buildbucket for the build status
[05:47:53.093] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:53.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:227:0) after 1m0s
[05:48:53.207] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:227:0)
[05:48:53.207] Timer tick, asking Buildbucket for the build status
[05:48:53.414] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:53.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:228:0) after 1m0s
[05:49:53.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:228:0)
[05:49:53.487] Timer tick, asking Buildbucket for the build status
[05:49:53.610] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:53.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:229:0) after 1m0s
[05:50:53.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:229:0)
[05:50:53.650] Timer tick, asking Buildbucket for the build status
[05:50:53.956] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:53.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:230:0) after 1m0s
[05:51:54.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:230:0)
[05:51:54.006] Timer tick, asking Buildbucket for the build status
[05:51:54.149] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:54.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:231:0) after 1m0s
[05:52:54.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:231:0)
[05:52:54.226] Timer tick, asking Buildbucket for the build status
[05:52:54.461] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:54.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:232:0) after 1m0s
[05:53:54.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:232:0)
[05:53:54.453] Timer tick, asking Buildbucket for the build status
[05:53:54.688] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:54.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:233:0) after 1m0s
[05:54:54.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:233:0)
[05:54:54.727] Timer tick, asking Buildbucket for the build status
[05:54:55.051] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:55.051] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:234:0) after 1m0s
[05:55:55.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:234:0)
[05:55:55.077] Timer tick, asking Buildbucket for the build status
[05:55:55.216] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:55.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:235:0) after 1m0s
[05:56:55.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:235:0)
[05:56:55.303] Timer tick, asking Buildbucket for the build status
[05:56:55.429] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:55.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:236:0) after 1m0s
[05:57:55.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:236:0)
[05:57:55.464] Timer tick, asking Buildbucket for the build status
[05:57:55.797] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:55.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:237:0) after 1m0s
[05:58:55.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:237:0)
[05:58:55.833] Timer tick, asking Buildbucket for the build status
[05:58:56.155] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:56.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:238:0) after 1m0s
[05:59:56.220] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:238:0)
[05:59:56.220] Timer tick, asking Buildbucket for the build status
[05:59:56.411] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:56.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:239:0) after 1m0s
[06:00:56.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:239:0)
[06:00:56.486] Timer tick, asking Buildbucket for the build status
[06:00:56.686] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:56.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:240:0) after 1m0s
[06:01:56.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:240:0)
[06:01:56.798] Timer tick, asking Buildbucket for the build status
[06:01:56.967] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:56.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:241:0) after 1m0s
[06:02:57.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:241:0)
[06:02:57.035] Timer tick, asking Buildbucket for the build status
[06:02:57.881] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:57.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:242:0) after 1m0s
[06:03:57.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:242:0)
[06:03:57.942] Timer tick, asking Buildbucket for the build status
[06:03:58.325] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:58.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:243:0) after 1m0s
[06:04:58.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:243:0)
[06:04:58.402] Timer tick, asking Buildbucket for the build status
[06:04:58.638] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:58.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:244:0) after 1m0s
[06:05:58.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:244:0)
[06:05:58.618] Timer tick, asking Buildbucket for the build status
[06:05:59.061] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:59.061] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:245:0) after 1m0s
[06:06:59.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:245:0)
[06:06:59.165] Timer tick, asking Buildbucket for the build status
[06:06:59.705] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:59.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:246:0) after 1m0s
[06:07:59.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:246:0)
[06:07:59.834] Timer tick, asking Buildbucket for the build status
[06:08:01.106] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:01.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:247:0) after 1m0s
[06:09:01.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:247:0)
[06:09:01.894] Timer tick, asking Buildbucket for the build status
[06:09:02.058] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:02.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:248:0) after 1m0s
[06:10:02.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:248:0)
[06:10:02.769] Timer tick, asking Buildbucket for the build status
[06:10:02.915] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:02.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:249:0) after 1m0s
[06:11:02.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:249:0)
[06:11:02.979] Timer tick, asking Buildbucket for the build status
[06:11:03.278] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:03.278] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:250:0) after 1m0s
[06:12:03.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:250:0)
[06:12:03.402] Timer tick, asking Buildbucket for the build status
[06:12:03.627] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:03.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:251:0) after 1m0s
[06:13:03.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:251:0)
[06:13:03.666] Timer tick, asking Buildbucket for the build status
[06:13:03.979] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:03.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:252:0) after 1m0s
[06:14:04.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:252:0)
[06:14:04.027] Timer tick, asking Buildbucket for the build status
[06:14:04.382] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:04.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:253:0) after 1m0s
[06:15:04.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:253:0)
[06:15:04.426] Timer tick, asking Buildbucket for the build status
[06:15:05.573] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:05.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:254:0) after 1m0s
[06:16:05.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:254:0)
[06:16:05.647] Timer tick, asking Buildbucket for the build status
[06:16:05.879] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:05.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:255:0) after 1m0s
[06:17:05.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:255:0)
[06:17:05.904] Timer tick, asking Buildbucket for the build status
[06:17:06.058] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:06.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:256:0) after 1m0s
[06:18:06.121] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:256:0)
[06:18:06.121] Timer tick, asking Buildbucket for the build status
[06:18:06.396] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:06.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:257:0) after 1m0s
[06:19:06.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:257:0)
[06:19:06.493] Timer tick, asking Buildbucket for the build status
[06:19:07.008] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:07.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:258:0) after 1m0s
[06:20:07.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:258:0)
[06:20:07.087] Timer tick, asking Buildbucket for the build status
[06:20:07.381] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:07.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:259:0) after 1m0s
[06:21:07.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:259:0)
[06:21:07.453] Timer tick, asking Buildbucket for the build status
[06:21:07.881] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:07.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:260:0) after 1m0s
[06:22:07.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:260:0)
[06:22:07.975] Timer tick, asking Buildbucket for the build status
[06:22:08.165] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:08.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:261:0) after 1m0s
[06:23:08.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:261:0)
[06:23:08.221] Timer tick, asking Buildbucket for the build status
[06:23:09.210] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:09.210] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:262:0) after 1m0s
[06:24:09.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:262:0)
[06:24:09.263] Timer tick, asking Buildbucket for the build status
[06:24:09.638] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:09.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:263:0) after 1m0s
[06:25:09.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:263:0)
[06:25:09.812] Timer tick, asking Buildbucket for the build status
[06:25:10.081] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:10.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:264:0) after 1m0s
[06:26:10.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:264:0)
[06:26:10.147] Timer tick, asking Buildbucket for the build status
[06:26:10.511] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:10.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:265:0) after 1m0s
[06:27:10.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:265:0)
[06:27:10.533] Timer tick, asking Buildbucket for the build status
[06:27:10.683] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:10.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:266:0) after 1m0s
[06:28:10.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:266:0)
[06:28:10.669] Timer tick, asking Buildbucket for the build status
[06:28:10.787] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:10.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:267:0) after 1m0s
[06:29:10.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:267:0)
[06:29:10.804] Timer tick, asking Buildbucket for the build status
[06:29:11.082] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:11.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:268:0) after 1m0s
[06:30:11.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:268:0)
[06:30:11.186] Timer tick, asking Buildbucket for the build status
[06:30:11.556] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:11.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:269:0) after 1m0s
[06:31:11.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:269:0)
[06:31:11.561] Timer tick, asking Buildbucket for the build status
[06:31:11.841] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:11.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:270:0) after 1m0s
[06:32:11.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:270:0)
[06:32:11.893] Timer tick, asking Buildbucket for the build status
[06:32:12.228] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:12.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:271:0) after 1m0s
[06:33:12.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:271:0)
[06:33:12.315] Timer tick, asking Buildbucket for the build status
[06:33:12.685] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:12.685] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:272:0) after 1m0s
[06:34:12.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:272:0)
[06:34:12.751] Timer tick, asking Buildbucket for the build status
[06:34:12.887] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:12.887] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:273:0) after 1m0s
[06:35:12.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:273:0)
[06:35:12.982] Timer tick, asking Buildbucket for the build status
[06:35:13.327] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:13.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:274:0) after 1m0s
[06:36:13.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:274:0)
[06:36:13.425] Timer tick, asking Buildbucket for the build status
[06:36:13.854] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:13.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:275:0) after 1m0s
[06:37:13.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:275:0)
[06:37:13.921] Timer tick, asking Buildbucket for the build status
[06:37:14.076] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:14.076] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:276:0) after 1m0s
[06:38:14.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:276:0)
[06:38:14.181] Timer tick, asking Buildbucket for the build status
[06:38:15.777] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:15.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:277:0) after 1m0s
[06:39:15.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:277:0)
[06:39:15.816] Timer tick, asking Buildbucket for the build status
[06:39:15.974] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:15.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:278:0) after 1m0s
[06:40:16.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:278:0)
[06:40:16.054] Timer tick, asking Buildbucket for the build status
[06:40:16.369] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:16.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:279:0) after 1m0s
[06:41:16.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:279:0)
[06:41:16.397] Timer tick, asking Buildbucket for the build status
[06:41:16.531] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:16.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:280:0) after 1m0s
[06:42:16.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:280:0)
[06:42:16.567] Timer tick, asking Buildbucket for the build status
[06:42:16.916] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:16.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:281:0) after 1m0s
[06:43:16.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:281:0)
[06:43:16.992] Timer tick, asking Buildbucket for the build status
[06:43:17.201] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:17.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:282:0) after 1m0s
[06:44:17.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:282:0)
[06:44:17.245] Timer tick, asking Buildbucket for the build status
[06:44:17.399] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:17.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:283:0) after 1m0s
[06:45:17.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:283:0)
[06:45:17.464] Timer tick, asking Buildbucket for the build status
[06:45:17.600] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:17.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:284:0) after 1m0s
[06:46:17.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:284:0)
[06:46:17.682] Timer tick, asking Buildbucket for the build status
[06:46:18.141] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:18.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:285:0) after 1m0s
[06:47:18.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:285:0)
[06:47:18.249] Timer tick, asking Buildbucket for the build status
[06:47:18.760] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:18.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:286:0) after 1m0s
[06:48:18.888] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:286:0)
[06:48:18.888] Timer tick, asking Buildbucket for the build status
[06:48:19.090] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:19.090] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:287:0) after 1m0s
[06:49:19.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:287:0)
[06:49:19.152] Timer tick, asking Buildbucket for the build status
[06:49:19.272] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:19.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:288:0) after 1m0s
[06:50:19.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:288:0)
[06:50:19.315] Timer tick, asking Buildbucket for the build status
[06:50:19.455] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:19.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:289:0) after 1m0s
[06:51:19.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:289:0)
[06:51:19.549] Timer tick, asking Buildbucket for the build status
[06:51:19.709] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:19.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:290:0) after 1m0s
[06:52:19.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:290:0)
[06:52:19.778] Timer tick, asking Buildbucket for the build status
[06:52:19.962] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:19.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:291:0) after 1m0s
[06:53:19.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:291:0)
[06:53:19.967] Timer tick, asking Buildbucket for the build status
[06:53:20.157] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:20.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:292:0) after 1m0s
[06:54:20.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:292:0)
[06:54:20.219] Timer tick, asking Buildbucket for the build status
[06:54:20.426] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:20.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:293:0) after 1m0s
[06:55:20.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:293:0)
[06:55:20.521] Timer tick, asking Buildbucket for the build status
[06:55:20.672] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:20.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:294:0) after 1m0s
[06:56:20.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:294:0)
[06:56:20.740] Timer tick, asking Buildbucket for the build status
[06:56:20.981] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:20.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:295:0) after 1m0s
[06:57:20.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:295:0)
[06:57:20.982] Timer tick, asking Buildbucket for the build status
[06:57:21.148] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:21.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:296:0) after 1m0s
[06:58:21.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:296:0)
[06:58:21.251] Timer tick, asking Buildbucket for the build status
[06:58:21.742] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:21.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:297:0) after 1m0s
[06:59:21.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:297:0)
[06:59:21.814] Timer tick, asking Buildbucket for the build status
[06:59:22.071] Build 8878552288703999776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:22.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043982350855001920:298:0) after 1m0s
[06:59:55.969] Received PubSub notification, asking Buildbucket for the build status
[06:59:56.038] Build 8878552288703999776: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:59:56.038] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1591167595138881",
    "created_by": "project:infra",
    "created_ts": "1591149737601355",
    "id": "8878552288703999776",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4162.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"7a1285a1-ead0-45ae-ab2e-06c4d87fd388\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4162.3\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-au2m\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5150-7dc5fa5\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1591156115396188",
    "status": "COMPLETED",
    "status_changed_ts": "1591167595632125",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9043982350855001920",
      "scheduler_job_id:infra/Build From Tarball",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8878552288703999776/+/annotations",
      "swarming_tag:luci_project:infra",
      "swarming_tag:os:Linux",
      "swarming_tag:recipe_name:build_from_tarball",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
      "swarming_task_id:4c90bbc44d18fb10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1591167595704621",
    "url": "https://ci.chromium.org/b/8878552288703999776",
    "utcnow_ts": "1591167596023898"
  }
}
[06:59:56.038] Invocation finished in 4h57m39.871338436s with status SUCCEEDED