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": "83.0.4101.0"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[16:59:18.081] New invocation is queued and will start shortly
[16:59:18.081] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[16:59:19.162] Starting the invocation (attempt 1)
[16:59:19.205] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:59:19.206] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:59:19.206] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9049633523387033776",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"83.0.4101.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"e6a97662-09fb-4df7-90c8-eac2804c7b20\",\"title\":\"publish_tarball/0\"}]},\"version\":\"83.0.4101.0\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9049633523387033776",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[16:59:19.848] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1585760359313958",
    "id": "8884203461430750416",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4101.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e6a97662-09fb-4df7-90c8-eac2804c7b20\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4101.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1585760359675565",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9049633523387033776",
      "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/8884203461430750416/+/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": "1585760359675733",
    "url": "https://ci.chromium.org/b/8884203461430750416",
    "utcnow_ts": "1585760359837624"
  }
}
[16:59:19.848] Task URL: https://ci.chromium.org/b/8884203461430750416
[16:59:19.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:2:0) after 1m0s
[17:00:19.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:2:0)
[17:00:19.848] Timer tick, asking Buildbucket for the build status
[17:00:20.239] Build 8884203461430750416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:00:20.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:3:0) after 1m0s
[17:01:20.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:3:0)
[17:01:20.449] Timer tick, asking Buildbucket for the build status
[17:01:20.614] Build 8884203461430750416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:01:20.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:4:0) after 1m0s
[17:02:20.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:4:0)
[17:02:20.713] Timer tick, asking Buildbucket for the build status
[17:02:20.885] Build 8884203461430750416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:02:20.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:5:0) after 1m0s
[17:03:20.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:5:0)
[17:03:20.908] Timer tick, asking Buildbucket for the build status
[17:03:22.527] Build 8884203461430750416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:03:22.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:6:0) after 1m0s
[17:04:22.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:6:0)
[17:04:22.669] Timer tick, asking Buildbucket for the build status
[17:04:22.890] Build 8884203461430750416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:04:22.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:7:0) after 1m0s
[17:05:22.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:7:0)
[17:05:22.972] Timer tick, asking Buildbucket for the build status
[17:05:24.602] Build 8884203461430750416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:05:24.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:8:0) after 1m0s
[17:06:24.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:8:0)
[17:06:24.803] Timer tick, asking Buildbucket for the build status
[17:06:25.004] Build 8884203461430750416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:06:25.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:9:0) after 1m0s
[17:07:25.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:9:0)
[17:07:25.193] Timer tick, asking Buildbucket for the build status
[17:07:25.477] Build 8884203461430750416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:07:25.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:10:0) after 1m0s
[17:08:25.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:10:0)
[17:08:25.533] Timer tick, asking Buildbucket for the build status
[17:08:25.936] Build 8884203461430750416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:08:25.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:11:0) after 1m0s
[17:08:51.156] Received PubSub notification, asking Buildbucket for the build status
[17:08:51.363] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:26.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:11:0)
[17:09:26.189] Timer tick, asking Buildbucket for the build status
[17:09:26.343] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:26.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:13:0) after 1m0s
[17:10:26.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:13:0)
[17:10:26.468] Timer tick, asking Buildbucket for the build status
[17:10:26.789] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:26.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:14:0) after 1m0s
[17:11:26.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:14:0)
[17:11:26.977] Timer tick, asking Buildbucket for the build status
[17:11:27.241] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:27.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:15:0) after 1m0s
[17:12:27.524] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:15:0)
[17:12:27.525] Timer tick, asking Buildbucket for the build status
[17:12:27.822] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:27.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:16:0) after 1m0s
[17:13:28.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:16:0)
[17:13:28.077] Timer tick, asking Buildbucket for the build status
[17:13:29.050] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:29.050] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:17:0) after 1m0s
[17:14:29.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:17:0)
[17:14:29.273] Timer tick, asking Buildbucket for the build status
[17:14:29.438] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:29.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:18:0) after 1m0s
[17:15:29.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:18:0)
[17:15:29.441] Timer tick, asking Buildbucket for the build status
[17:15:29.619] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:29.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:19:0) after 1m0s
[17:16:29.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:19:0)
[17:16:29.609] Timer tick, asking Buildbucket for the build status
[17:16:29.780] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:29.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:20:0) after 1m0s
[17:17:29.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:20:0)
[17:17:29.802] Timer tick, asking Buildbucket for the build status
[17:17:30.053] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:30.053] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:21:0) after 1m0s
[17:18:30.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:21:0)
[17:18:30.163] Timer tick, asking Buildbucket for the build status
[17:18:34.700] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:34.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:22:0) after 1m0s
[17:19:34.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:22:0)
[17:19:34.840] Timer tick, asking Buildbucket for the build status
[17:19:35.029] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:35.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:23:0) after 1m0s
[17:20:35.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:23:0)
[17:20:35.277] Timer tick, asking Buildbucket for the build status
[17:20:35.471] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:35.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:24:0) after 1m0s
[17:21:35.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:24:0)
[17:21:35.749] Timer tick, asking Buildbucket for the build status
[17:21:35.948] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:35.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:25:0) after 1m0s
[17:22:35.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:25:0)
[17:22:35.967] Timer tick, asking Buildbucket for the build status
[17:22:36.342] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:36.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:26:0) after 1m0s
[17:23:36.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:26:0)
[17:23:36.394] Timer tick, asking Buildbucket for the build status
[17:23:36.827] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:36.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:27:0) after 1m0s
[17:24:36.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:27:0)
[17:24:36.902] Timer tick, asking Buildbucket for the build status
[17:24:37.264] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:37.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:28:0) after 1m0s
[17:25:37.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:28:0)
[17:25:37.362] Timer tick, asking Buildbucket for the build status
[17:25:37.856] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:37.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:29:0) after 1m0s
[17:26:37.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:29:0)
[17:26:37.992] Timer tick, asking Buildbucket for the build status
[17:26:38.494] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:38.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:30:0) after 1m0s
[17:27:38.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:30:0)
[17:27:38.519] Timer tick, asking Buildbucket for the build status
[17:27:39.735] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:39.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:31:0) after 1m0s
[17:28:39.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:31:0)
[17:28:39.863] Timer tick, asking Buildbucket for the build status
[17:28:40.528] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:40.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:32:0) after 1m0s
[17:29:40.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:32:0)
[17:29:40.639] Timer tick, asking Buildbucket for the build status
[17:29:41.433] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:41.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:33:0) after 1m0s
[17:30:41.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:33:0)
[17:30:41.473] Timer tick, asking Buildbucket for the build status
[17:30:46.649] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:46.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:34:0) after 1m0s
[17:31:47.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:34:0)
[17:31:47.038] Timer tick, asking Buildbucket for the build status
[17:31:47.201] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:47.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:35:0) after 1m0s
[17:32:47.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:35:0)
[17:32:47.259] Timer tick, asking Buildbucket for the build status
[17:32:47.371] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:47.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:36:0) after 1m0s
[17:33:47.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:36:0)
[17:33:47.448] Timer tick, asking Buildbucket for the build status
[17:33:48.061] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:48.061] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:37:0) after 1m0s
[17:34:48.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:37:0)
[17:34:48.430] Timer tick, asking Buildbucket for the build status
[17:34:48.836] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:48.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:38:0) after 1m0s
[17:35:49.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:38:0)
[17:35:49.075] Timer tick, asking Buildbucket for the build status
[17:35:49.237] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:49.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:39:0) after 1m0s
[17:36:49.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:39:0)
[17:36:49.475] Timer tick, asking Buildbucket for the build status
[17:36:49.815] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:49.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:40:0) after 1m0s
[17:37:49.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:40:0)
[17:37:49.853] Timer tick, asking Buildbucket for the build status
[17:37:50.023] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:50.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:41:0) after 1m0s
[17:38:50.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:41:0)
[17:38:50.111] Timer tick, asking Buildbucket for the build status
[17:38:50.310] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:50.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:42:0) after 1m0s
[17:39:50.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:42:0)
[17:39:50.361] Timer tick, asking Buildbucket for the build status
[17:39:50.775] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:50.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:43:0) after 1m0s
[17:40:50.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:43:0)
[17:40:50.803] Timer tick, asking Buildbucket for the build status
[17:40:50.985] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:50.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:44:0) after 1m0s
[17:41:51.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:44:0)
[17:41:51.052] Timer tick, asking Buildbucket for the build status
[17:41:51.367] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:51.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:45:0) after 1m0s
[17:42:51.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:45:0)
[17:42:51.928] Timer tick, asking Buildbucket for the build status
[17:42:52.729] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:52.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:46:0) after 1m0s
[17:43:53.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:46:0)
[17:43:53.033] Timer tick, asking Buildbucket for the build status
[17:43:53.309] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:53.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:47:0) after 1m0s
[17:44:53.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:47:0)
[17:44:53.533] Timer tick, asking Buildbucket for the build status
[17:44:53.765] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:53.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:48:0) after 1m0s
[17:45:54.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:48:0)
[17:45:54.009] Timer tick, asking Buildbucket for the build status
[17:45:54.163] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:54.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:49:0) after 1m0s
[17:46:54.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:49:0)
[17:46:54.353] Timer tick, asking Buildbucket for the build status
[17:46:54.565] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:54.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:50:0) after 1m0s
[17:47:54.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:50:0)
[17:47:54.801] Timer tick, asking Buildbucket for the build status
[17:47:54.950] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:54.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:51:0) after 1m0s
[17:48:55.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:51:0)
[17:48:55.087] Timer tick, asking Buildbucket for the build status
[17:48:55.344] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:55.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:52:0) after 1m0s
[17:49:55.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:52:0)
[17:49:55.629] Timer tick, asking Buildbucket for the build status
[17:49:55.889] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:55.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:53:0) after 1m0s
[17:50:56.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:53:0)
[17:50:56.199] Timer tick, asking Buildbucket for the build status
[17:50:56.383] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:56.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:54:0) after 1m0s
[17:51:56.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:54:0)
[17:51:56.526] Timer tick, asking Buildbucket for the build status
[17:51:56.712] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:56.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:55:0) after 1m0s
[17:52:56.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:55:0)
[17:52:56.871] Timer tick, asking Buildbucket for the build status
[17:52:57.035] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:57.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:56:0) after 1m0s
[17:53:57.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:56:0)
[17:53:57.230] Timer tick, asking Buildbucket for the build status
[17:53:57.500] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:57.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:57:0) after 1m0s
[17:54:57.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:57:0)
[17:54:57.587] Timer tick, asking Buildbucket for the build status
[17:54:57.755] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:57.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:58:0) after 1m0s
[17:55:57.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:58:0)
[17:55:57.815] Timer tick, asking Buildbucket for the build status
[17:55:58.018] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:58.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:59:0) after 1m0s
[17:56:58.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:59:0)
[17:56:58.152] Timer tick, asking Buildbucket for the build status
[17:56:58.392] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:58.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:60:0) after 1m0s
[17:57:58.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:60:0)
[17:57:58.563] Timer tick, asking Buildbucket for the build status
[17:57:59.640] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:59.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:61:0) after 1m0s
[17:58:59.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:61:0)
[17:58:59.809] Timer tick, asking Buildbucket for the build status
[17:59:00.208] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:00.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:62:0) after 1m0s
[18:00:00.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:62:0)
[18:00:00.457] Timer tick, asking Buildbucket for the build status
[18:00:00.823] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:00.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:63:0) after 1m0s
[18:01:01.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:63:0)
[18:01:01.107] Timer tick, asking Buildbucket for the build status
[18:01:01.927] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:01.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:64:0) after 1m0s
[18:02:02.269] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:64:0)
[18:02:02.269] Timer tick, asking Buildbucket for the build status
[18:02:02.732] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:02.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:65:0) after 1m0s
[18:03:02.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:65:0)
[18:03:02.881] Timer tick, asking Buildbucket for the build status
[18:03:03.086] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:03.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:66:0) after 1m0s
[18:04:03.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:66:0)
[18:04:03.317] Timer tick, asking Buildbucket for the build status
[18:04:03.661] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:03.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:67:0) after 1m0s
[18:05:03.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:67:0)
[18:05:03.687] Timer tick, asking Buildbucket for the build status
[18:05:04.233] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:04.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:68:0) after 1m0s
[18:06:04.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:68:0)
[18:06:04.265] Timer tick, asking Buildbucket for the build status
[18:06:04.469] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:04.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:69:0) after 1m0s
[18:07:04.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:69:0)
[18:07:04.558] Timer tick, asking Buildbucket for the build status
[18:07:04.777] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:04.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:70:0) after 1m0s
[18:08:04.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:70:0)
[18:08:04.822] Timer tick, asking Buildbucket for the build status
[18:08:05.011] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:05.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:71:0) after 1m0s
[18:09:05.040] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:71:0)
[18:09:05.040] Timer tick, asking Buildbucket for the build status
[18:09:05.284] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:05.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:72:0) after 1m0s
[18:10:05.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:72:0)
[18:10:05.423] Timer tick, asking Buildbucket for the build status
[18:10:05.670] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:05.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:73:0) after 1m0s
[18:11:05.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:73:0)
[18:11:05.767] Timer tick, asking Buildbucket for the build status
[18:11:05.964] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:05.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:74:0) after 1m0s
[18:12:06.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:74:0)
[18:12:06.044] Timer tick, asking Buildbucket for the build status
[18:12:06.165] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:06.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:75:0) after 1m0s
[18:13:06.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:75:0)
[18:13:06.215] Timer tick, asking Buildbucket for the build status
[18:13:06.438] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:06.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:76:0) after 1m0s
[18:14:06.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:76:0)
[18:14:06.499] Timer tick, asking Buildbucket for the build status
[18:14:06.715] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:06.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:77:0) after 1m0s
[18:15:06.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:77:0)
[18:15:06.830] Timer tick, asking Buildbucket for the build status
[18:15:07.552] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:07.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:78:0) after 1m0s
[18:16:07.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:78:0)
[18:16:07.640] Timer tick, asking Buildbucket for the build status
[18:16:07.853] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:07.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:79:0) after 1m0s
[18:17:07.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:79:0)
[18:17:07.881] Timer tick, asking Buildbucket for the build status
[18:17:08.411] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:08.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:80:0) after 1m0s
[18:18:08.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:80:0)
[18:18:08.675] Timer tick, asking Buildbucket for the build status
[18:18:08.883] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:08.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:81:0) after 1m0s
[18:19:08.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:81:0)
[18:19:08.936] Timer tick, asking Buildbucket for the build status
[18:19:09.372] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:09.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:82:0) after 1m0s
[18:20:09.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:82:0)
[18:20:09.502] Timer tick, asking Buildbucket for the build status
[18:20:09.933] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:09.933] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:83:0) after 1m0s
[18:21:10.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:83:0)
[18:21:10.069] Timer tick, asking Buildbucket for the build status
[18:21:10.345] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:10.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:84:0) after 1m0s
[18:22:10.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:84:0)
[18:22:10.418] Timer tick, asking Buildbucket for the build status
[18:22:10.569] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:10.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:85:0) after 1m0s
[18:23:11.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:85:0)
[18:23:11.133] Timer tick, asking Buildbucket for the build status
[18:23:13.127] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:13.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:86:0) after 1m0s
[18:24:13.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:86:0)
[18:24:13.247] Timer tick, asking Buildbucket for the build status
[18:24:13.544] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:13.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:87:0) after 1m0s
[18:25:13.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:87:0)
[18:25:13.552] Timer tick, asking Buildbucket for the build status
[18:25:14.167] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:14.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:88:0) after 1m0s
[18:26:14.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:88:0)
[18:26:14.203] Timer tick, asking Buildbucket for the build status
[18:26:14.475] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:14.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:89:0) after 1m0s
[18:27:14.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:89:0)
[18:27:14.533] Timer tick, asking Buildbucket for the build status
[18:27:14.922] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:14.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:90:0) after 1m0s
[18:28:15.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:90:0)
[18:28:15.038] Timer tick, asking Buildbucket for the build status
[18:28:15.259] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:15.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:91:0) after 1m0s
[18:29:15.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:91:0)
[18:29:15.489] Timer tick, asking Buildbucket for the build status
[18:29:15.821] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:15.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:92:0) after 1m0s
[18:30:16.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:92:0)
[18:30:16.097] Timer tick, asking Buildbucket for the build status
[18:30:16.430] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:16.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:93:0) after 1m0s
[18:31:16.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:93:0)
[18:31:16.549] Timer tick, asking Buildbucket for the build status
[18:31:16.956] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:16.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:94:0) after 1m0s
[18:32:17.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:94:0)
[18:32:17.047] Timer tick, asking Buildbucket for the build status
[18:32:17.272] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:17.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:95:0) after 1m0s
[18:33:17.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:95:0)
[18:33:17.324] Timer tick, asking Buildbucket for the build status
[18:33:17.438] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:17.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:96:0) after 1m0s
[18:34:17.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:96:0)
[18:34:17.486] Timer tick, asking Buildbucket for the build status
[18:34:17.635] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:17.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:97:0) after 1m0s
[18:35:17.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:97:0)
[18:35:17.806] Timer tick, asking Buildbucket for the build status
[18:35:19.371] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:19.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:98:0) after 1m0s
[18:36:19.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:98:0)
[18:36:19.480] Timer tick, asking Buildbucket for the build status
[18:36:19.745] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:19.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:99:0) after 1m0s
[18:37:19.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:99:0)
[18:37:19.839] Timer tick, asking Buildbucket for the build status
[18:37:20.267] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:20.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:100:0) after 1m0s
[18:38:20.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:100:0)
[18:38:20.331] Timer tick, asking Buildbucket for the build status
[18:38:20.490] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:20.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:101:0) after 1m0s
[18:39:20.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:101:0)
[18:39:20.558] Timer tick, asking Buildbucket for the build status
[18:39:20.828] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:20.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:102:0) after 1m0s
[18:40:20.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:102:0)
[18:40:20.868] Timer tick, asking Buildbucket for the build status
[18:40:22.474] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:22.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:103:0) after 1m0s
[18:41:22.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:103:0)
[18:41:22.561] Timer tick, asking Buildbucket for the build status
[18:41:22.792] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:22.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:104:0) after 1m0s
[18:42:22.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:104:0)
[18:42:22.791] Timer tick, asking Buildbucket for the build status
[18:42:22.998] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:22.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:105:0) after 1m0s
[18:43:22.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:105:0)
[18:43:22.986] Timer tick, asking Buildbucket for the build status
[18:43:23.935] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:23.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:106:0) after 1m0s
[18:44:24.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:106:0)
[18:44:24.027] Timer tick, asking Buildbucket for the build status
[18:44:24.452] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:24.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:107:0) after 1m0s
[18:45:24.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:107:0)
[18:45:24.507] Timer tick, asking Buildbucket for the build status
[18:45:24.715] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:24.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:108:0) after 1m0s
[18:46:24.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:108:0)
[18:46:24.750] Timer tick, asking Buildbucket for the build status
[18:46:25.218] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:25.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:109:0) after 1m0s
[18:47:25.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:109:0)
[18:47:25.256] Timer tick, asking Buildbucket for the build status
[18:47:25.598] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:25.598] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:110:0) after 1m0s
[18:48:25.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:110:0)
[18:48:25.631] Timer tick, asking Buildbucket for the build status
[18:48:29.519] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:29.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:111:0) after 1m0s
[18:49:29.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:111:0)
[18:49:29.552] Timer tick, asking Buildbucket for the build status
[18:49:29.956] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:29.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:112:0) after 1m0s
[18:50:30.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:112:0)
[18:50:30.028] Timer tick, asking Buildbucket for the build status
[18:50:30.536] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:30.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:113:0) after 1m0s
[18:51:30.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:113:0)
[18:51:30.597] Timer tick, asking Buildbucket for the build status
[18:51:31.252] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:31.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:114:0) after 1m0s
[18:52:31.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:114:0)
[18:52:31.370] Timer tick, asking Buildbucket for the build status
[18:52:31.493] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:31.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:115:0) after 1m0s
[18:53:31.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:115:0)
[18:53:31.640] Timer tick, asking Buildbucket for the build status
[18:53:34.918] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:34.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:116:0) after 1m0s
[18:54:34.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:116:0)
[18:54:34.960] Timer tick, asking Buildbucket for the build status
[18:54:35.147] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:35.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:117:0) after 1m0s
[18:55:35.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:117:0)
[18:55:35.146] Timer tick, asking Buildbucket for the build status
[18:55:37.014] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:37.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:118:0) after 1m0s
[18:56:37.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:118:0)
[18:56:37.138] Timer tick, asking Buildbucket for the build status
[18:56:37.451] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:37.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:119:0) after 1m0s
[18:57:37.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:119:0)
[18:57:37.515] Timer tick, asking Buildbucket for the build status
[18:57:37.715] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:37.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:120:0) after 1m0s
[18:58:37.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:120:0)
[18:58:37.725] Timer tick, asking Buildbucket for the build status
[18:58:38.852] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:38.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:121:0) after 1m0s
[18:59:39.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:121:0)
[18:59:39.054] Timer tick, asking Buildbucket for the build status
[18:59:39.283] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:39.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:122:0) after 1m0s
[19:00:39.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:122:0)
[19:00:39.284] Timer tick, asking Buildbucket for the build status
[19:00:39.464] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:39.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:123:0) after 1m0s
[19:01:39.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:123:0)
[19:01:39.489] Timer tick, asking Buildbucket for the build status
[19:01:40.551] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:40.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:124:0) after 1m0s
[19:02:40.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:124:0)
[19:02:40.646] Timer tick, asking Buildbucket for the build status
[19:02:40.956] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:40.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:125:0) after 1m0s
[19:03:41.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:125:0)
[19:03:41.038] Timer tick, asking Buildbucket for the build status
[19:03:41.334] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:41.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:126:0) after 1m0s
[19:04:41.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:126:0)
[19:04:41.506] Timer tick, asking Buildbucket for the build status
[19:04:41.964] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:41.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:127:0) after 1m0s
[19:05:42.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:127:0)
[19:05:42.028] Timer tick, asking Buildbucket for the build status
[19:05:42.476] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:42.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:128:0) after 1m0s
[19:06:42.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:128:0)
[19:06:42.552] Timer tick, asking Buildbucket for the build status
[19:06:42.773] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:42.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:129:0) after 1m0s
[19:07:42.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:129:0)
[19:07:42.805] Timer tick, asking Buildbucket for the build status
[19:07:43.222] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:43.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:130:0) after 1m0s
[19:08:43.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:130:0)
[19:08:43.296] Timer tick, asking Buildbucket for the build status
[19:08:44.530] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:44.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:131:0) after 1m0s
[19:09:44.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:131:0)
[19:09:44.558] Timer tick, asking Buildbucket for the build status
[19:09:44.998] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:44.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:132:0) after 1m0s
[19:10:45.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:132:0)
[19:10:45.023] Timer tick, asking Buildbucket for the build status
[19:10:45.571] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:45.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:133:0) after 1m0s
[19:11:45.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:133:0)
[19:11:45.609] Timer tick, asking Buildbucket for the build status
[19:11:45.815] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:45.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:134:0) after 1m0s
[19:12:45.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:134:0)
[19:12:45.846] Timer tick, asking Buildbucket for the build status
[19:12:46.012] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:46.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:135:0) after 1m0s
[19:13:46.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:135:0)
[19:13:46.065] Timer tick, asking Buildbucket for the build status
[19:13:46.852] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:46.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:136:0) after 1m0s
[19:14:47.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:136:0)
[19:14:47.016] Timer tick, asking Buildbucket for the build status
[19:14:48.756] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:48.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:137:0) after 1m0s
[19:15:48.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:137:0)
[19:15:48.780] Timer tick, asking Buildbucket for the build status
[19:15:48.936] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:48.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:138:0) after 1m0s
[19:16:48.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:138:0)
[19:16:48.947] Timer tick, asking Buildbucket for the build status
[19:16:49.268] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:49.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:139:0) after 1m0s
[19:17:49.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:139:0)
[19:17:49.282] Timer tick, asking Buildbucket for the build status
[19:17:49.418] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:49.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:140:0) after 1m0s
[19:18:49.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:140:0)
[19:18:49.518] Timer tick, asking Buildbucket for the build status
[19:18:49.841] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:49.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:141:0) after 1m0s
[19:19:49.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:141:0)
[19:19:49.927] Timer tick, asking Buildbucket for the build status
[19:19:50.073] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:50.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:142:0) after 1m0s
[19:20:50.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:142:0)
[19:20:50.105] Timer tick, asking Buildbucket for the build status
[19:20:50.431] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:50.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:143:0) after 1m0s
[19:21:50.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:143:0)
[19:21:50.516] Timer tick, asking Buildbucket for the build status
[19:21:51.193] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:51.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:144:0) after 1m0s
[19:22:51.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:144:0)
[19:22:51.302] Timer tick, asking Buildbucket for the build status
[19:22:51.425] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:51.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:145:0) after 1m0s
[19:23:51.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:145:0)
[19:23:51.528] Timer tick, asking Buildbucket for the build status
[19:23:51.672] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:51.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:146:0) after 1m0s
[19:24:51.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:146:0)
[19:24:51.896] Timer tick, asking Buildbucket for the build status
[19:24:52.101] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:52.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:147:0) after 1m0s
[19:25:52.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:147:0)
[19:25:52.232] Timer tick, asking Buildbucket for the build status
[19:25:52.653] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:52.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:148:0) after 1m0s
[19:26:52.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:148:0)
[19:26:52.701] Timer tick, asking Buildbucket for the build status
[19:26:53.074] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:53.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:149:0) after 1m0s
[19:27:53.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:149:0)
[19:27:53.252] Timer tick, asking Buildbucket for the build status
[19:27:53.763] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:53.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:150:0) after 1m0s
[19:28:53.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:150:0)
[19:28:53.971] Timer tick, asking Buildbucket for the build status
[19:28:54.667] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:54.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:151:0) after 1m0s
[19:29:54.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:151:0)
[19:29:54.737] Timer tick, asking Buildbucket for the build status
[19:29:55.102] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:55.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:152:0) after 1m0s
[19:30:55.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:152:0)
[19:30:55.110] Timer tick, asking Buildbucket for the build status
[19:30:55.411] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:55.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:153:0) after 1m0s
[19:31:55.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:153:0)
[19:31:55.530] Timer tick, asking Buildbucket for the build status
[19:31:55.845] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:55.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:154:0) after 1m0s
[19:32:55.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:154:0)
[19:32:55.918] Timer tick, asking Buildbucket for the build status
[19:32:56.634] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:56.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:155:0) after 1m0s
[19:33:56.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:155:0)
[19:33:56.661] Timer tick, asking Buildbucket for the build status
[19:33:56.991] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:56.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:156:0) after 1m0s
[19:34:57.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:156:0)
[19:34:57.048] Timer tick, asking Buildbucket for the build status
[19:34:57.188] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:57.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:157:0) after 1m0s
[19:35:57.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:157:0)
[19:35:57.361] Timer tick, asking Buildbucket for the build status
[19:35:57.784] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:57.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:158:0) after 1m0s
[19:36:57.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:158:0)
[19:36:57.817] Timer tick, asking Buildbucket for the build status
[19:36:58.353] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:58.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:159:0) after 1m0s
[19:37:58.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:159:0)
[19:37:58.397] Timer tick, asking Buildbucket for the build status
[19:37:58.623] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:58.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:160:0) after 1m0s
[19:38:58.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:160:0)
[19:38:58.759] Timer tick, asking Buildbucket for the build status
[19:38:58.974] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:58.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:161:0) after 1m0s
[19:39:59.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:161:0)
[19:39:59.085] Timer tick, asking Buildbucket for the build status
[19:39:59.329] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:59.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:162:0) after 1m0s
[19:40:59.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:162:0)
[19:40:59.544] Timer tick, asking Buildbucket for the build status
[19:40:59.716] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:59.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:163:0) after 1m0s
[19:41:59.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:163:0)
[19:41:59.849] Timer tick, asking Buildbucket for the build status
[19:42:00.144] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:00.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:164:0) after 1m0s
[19:43:00.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:164:0)
[19:43:00.284] Timer tick, asking Buildbucket for the build status
[19:43:00.753] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:00.753] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:165:0) after 1m0s
[19:44:00.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:165:0)
[19:44:00.883] Timer tick, asking Buildbucket for the build status
[19:44:01.072] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:01.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:166:0) after 1m0s
[19:45:01.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:166:0)
[19:45:01.174] Timer tick, asking Buildbucket for the build status
[19:45:01.318] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:01.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:167:0) after 1m0s
[19:46:01.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:167:0)
[19:46:01.566] Timer tick, asking Buildbucket for the build status
[19:46:01.793] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:01.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:168:0) after 1m0s
[19:47:01.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:168:0)
[19:47:01.819] Timer tick, asking Buildbucket for the build status
[19:47:02.043] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:02.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:169:0) after 1m0s
[19:48:02.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:169:0)
[19:48:02.131] Timer tick, asking Buildbucket for the build status
[19:48:02.272] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:02.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:170:0) after 1m0s
[19:49:02.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:170:0)
[19:49:02.375] Timer tick, asking Buildbucket for the build status
[19:49:02.576] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:02.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:171:0) after 1m0s
[19:50:02.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:171:0)
[19:50:02.695] Timer tick, asking Buildbucket for the build status
[19:50:02.944] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:02.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:172:0) after 1m0s
[19:51:03.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:172:0)
[19:51:03.057] Timer tick, asking Buildbucket for the build status
[19:51:03.609] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:03.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:173:0) after 1m0s
[19:52:03.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:173:0)
[19:52:03.668] Timer tick, asking Buildbucket for the build status
[19:52:03.934] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:03.934] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:174:0) after 1m0s
[19:53:03.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:174:0)
[19:53:03.997] Timer tick, asking Buildbucket for the build status
[19:53:04.222] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:04.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:175:0) after 1m0s
[19:54:04.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:175:0)
[19:54:04.321] Timer tick, asking Buildbucket for the build status
[19:54:04.579] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:04.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:176:0) after 1m0s
[19:55:04.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:176:0)
[19:55:04.631] Timer tick, asking Buildbucket for the build status
[19:55:04.889] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:04.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:177:0) after 1m0s
[19:56:04.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:177:0)
[19:56:04.939] Timer tick, asking Buildbucket for the build status
[19:56:05.119] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:05.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:178:0) after 1m0s
[19:57:05.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:178:0)
[19:57:05.126] Timer tick, asking Buildbucket for the build status
[19:57:05.629] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:05.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:179:0) after 1m0s
[19:58:05.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:179:0)
[19:58:05.633] Timer tick, asking Buildbucket for the build status
[19:58:05.814] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:05.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:180:0) after 1m0s
[19:59:05.944] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:180:0)
[19:59:05.944] Timer tick, asking Buildbucket for the build status
[19:59:06.151] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:06.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:181:0) after 1m0s
[20:00:06.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:181:0)
[20:00:06.258] Timer tick, asking Buildbucket for the build status
[20:00:06.561] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:06.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:182:0) after 1m0s
[20:01:06.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:182:0)
[20:01:06.670] Timer tick, asking Buildbucket for the build status
[20:01:07.239] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:07.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:183:0) after 1m0s
[20:02:07.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:183:0)
[20:02:07.282] Timer tick, asking Buildbucket for the build status
[20:02:07.488] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:07.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:184:0) after 1m0s
[20:03:07.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:184:0)
[20:03:07.602] Timer tick, asking Buildbucket for the build status
[20:03:08.341] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:08.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:185:0) after 1m0s
[20:04:08.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:185:0)
[20:04:08.458] Timer tick, asking Buildbucket for the build status
[20:04:08.605] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:08.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:186:0) after 1m0s
[20:05:08.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:186:0)
[20:05:08.657] Timer tick, asking Buildbucket for the build status
[20:05:08.906] Build 8884203461430750416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:08.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049633523387033776:187:0) after 1m0s
[20:05:53.119] Received PubSub notification, asking Buildbucket for the build status
[20:05:53.219] Build 8884203461430750416: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:05:53.219] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1585771551710651",
    "created_by": "project:infra",
    "created_ts": "1585760359313958",
    "id": "8884203461430750416",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4101.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e6a97662-09fb-4df7-90c8-eac2804c7b20\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4101.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4101.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e6a97662-09fb-4df7-90c8-eac2804c7b20\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-cvra\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"83.0.4101.0\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"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-cvra\"], \"image\": [\"chrome-xenial-20032900-6802ab9ce34\"], \"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\": [\"4916-b2318d4\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1585760929600567",
    "status": "COMPLETED",
    "status_changed_ts": "1585771552604625",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9049633523387033776",
      "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/8884203461430750416/+/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:4b4f80629df04210",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1585771552660236",
    "url": "https://ci.chromium.org/b/8884203461430750416",
    "utcnow_ts": "1585771553204111"
  }
}
[20:05:53.219] Invocation finished in 3h6m35.154396049s with status SUCCEEDED