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

• parent_buildername:publish_tarball
• user_agent:recipe

[19:48:01.033] New invocation is queued and will start shortly
[19:48:01.033] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[19:48:02.480] Starting the invocation (attempt 1)
[19:48:02.521] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:48:02.524] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:48:02.524] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9048082760272989696",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"84.0.4118.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"bc01ab73-b980-40bb-92d2-f1735c3ef577\",\"title\":\"publish_tarball/0\"}]},\"version\":\"84.0.4118.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:9048082760272989696",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[19:48:03.248] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1587239282643757",
    "id": "8882652697921631120",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4118.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"bc01ab73-b980-40bb-92d2-f1735c3ef577\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4118.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1587239282887716",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9048082760272989696",
      "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/8882652697921631120/+/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": "1587239282887855",
    "url": "https://ci.chromium.org/b/8882652697921631120",
    "utcnow_ts": "1587239283224688"
  }
}
[19:48:03.248] Task URL: https://ci.chromium.org/b/8882652697921631120
[19:48:03.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:2:0) after 1m0s
[19:49:03.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:2:0)
[19:49:03.308] Timer tick, asking Buildbucket for the build status
[19:49:03.453] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:03.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:3:0) after 1m0s
[19:50:03.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:3:0)
[19:50:03.494] Timer tick, asking Buildbucket for the build status
[19:50:03.633] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:03.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:4:0) after 1m0s
[19:51:03.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:4:0)
[19:51:03.687] Timer tick, asking Buildbucket for the build status
[19:51:04.001] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:51:04.001] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:5:0) after 1m0s
[19:52:04.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:5:0)
[19:52:04.020] Timer tick, asking Buildbucket for the build status
[19:52:04.179] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:04.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:6:0) after 1m0s
[19:53:04.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:6:0)
[19:53:04.198] Timer tick, asking Buildbucket for the build status
[19:53:04.392] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:04.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:7:0) after 1m0s
[19:54:04.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:7:0)
[19:54:04.468] Timer tick, asking Buildbucket for the build status
[19:54:04.632] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:04.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:8:0) after 1m0s
[19:55:04.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:8:0)
[19:55:04.750] Timer tick, asking Buildbucket for the build status
[19:55:04.872] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:04.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:9:0) after 1m0s
[19:56:04.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:9:0)
[19:56:04.890] Timer tick, asking Buildbucket for the build status
[19:56:05.068] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:05.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:10:0) after 1m0s
[19:57:05.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:10:0)
[19:57:05.168] Timer tick, asking Buildbucket for the build status
[19:57:05.335] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:05.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:11:0) after 1m0s
[19:58:05.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:11:0)
[19:58:05.391] Timer tick, asking Buildbucket for the build status
[19:58:05.539] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:58:05.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:12:0) after 1m0s
[19:59:05.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:12:0)
[19:59:05.568] Timer tick, asking Buildbucket for the build status
[19:59:05.693] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:05.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:13:0) after 1m0s
[20:00:05.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:13:0)
[20:00:05.768] Timer tick, asking Buildbucket for the build status
[20:00:05.908] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:05.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:14:0) after 1m0s
[20:01:05.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:14:0)
[20:01:05.932] Timer tick, asking Buildbucket for the build status
[20:01:06.318] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:06.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:15:0) after 1m0s
[20:02:06.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:15:0)
[20:02:06.361] Timer tick, asking Buildbucket for the build status
[20:02:06.521] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:06.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:16:0) after 1m0s
[20:03:06.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:16:0)
[20:03:06.593] Timer tick, asking Buildbucket for the build status
[20:03:06.796] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:06.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:17:0) after 1m0s
[20:04:06.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:17:0)
[20:04:06.820] Timer tick, asking Buildbucket for the build status
[20:04:07.167] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:07.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:18:0) after 1m0s
[20:05:07.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:18:0)
[20:05:07.195] Timer tick, asking Buildbucket for the build status
[20:05:07.609] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:07.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:19:0) after 1m0s
[20:06:07.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:19:0)
[20:06:07.701] Timer tick, asking Buildbucket for the build status
[20:06:07.930] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:07.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:20:0) after 1m0s
[20:07:07.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:20:0)
[20:07:07.973] Timer tick, asking Buildbucket for the build status
[20:07:08.260] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:08.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:21:0) after 1m0s
[20:08:08.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:21:0)
[20:08:08.282] Timer tick, asking Buildbucket for the build status
[20:08:08.578] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:08.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:22:0) after 1m0s
[20:09:08.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:22:0)
[20:09:08.651] Timer tick, asking Buildbucket for the build status
[20:09:08.808] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:08.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:23:0) after 1m0s
[20:10:08.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:23:0)
[20:10:08.842] Timer tick, asking Buildbucket for the build status
[20:10:09.237] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:09.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:24:0) after 1m0s
[20:11:09.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:24:0)
[20:11:09.277] Timer tick, asking Buildbucket for the build status
[20:11:09.771] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:09.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:25:0) after 1m0s
[20:12:09.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:25:0)
[20:12:09.795] Timer tick, asking Buildbucket for the build status
[20:12:10.003] Build 8882652697921631120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:10.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:26:0) after 1m0s
[20:12:36.672] Received PubSub notification, asking Buildbucket for the build status
[20:12:36.855] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:10.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:26:0)
[20:13:10.007] Timer tick, asking Buildbucket for the build status
[20:13:10.311] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:10.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:28:0) after 1m0s
[20:14:10.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:28:0)
[20:14:10.337] Timer tick, asking Buildbucket for the build status
[20:14:10.621] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:10.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:29:0) after 1m0s
[20:15:10.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:29:0)
[20:15:10.754] Timer tick, asking Buildbucket for the build status
[20:15:10.901] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:10.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:30:0) after 1m0s
[20:16:10.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:30:0)
[20:16:10.945] Timer tick, asking Buildbucket for the build status
[20:16:11.364] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:11.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:31:0) after 1m0s
[20:17:11.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:31:0)
[20:17:11.441] Timer tick, asking Buildbucket for the build status
[20:17:11.731] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:11.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:32:0) after 1m0s
[20:18:11.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:32:0)
[20:18:11.846] Timer tick, asking Buildbucket for the build status
[20:18:12.147] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:12.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:33:0) after 1m0s
[20:19:12.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:33:0)
[20:19:12.227] Timer tick, asking Buildbucket for the build status
[20:19:12.384] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:12.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:34:0) after 1m0s
[20:20:12.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:34:0)
[20:20:12.500] Timer tick, asking Buildbucket for the build status
[20:20:12.787] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:12.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:35:0) after 1m0s
[20:21:12.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:35:0)
[20:21:12.861] Timer tick, asking Buildbucket for the build status
[20:21:12.985] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:12.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:36:0) after 1m0s
[20:22:13.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:36:0)
[20:22:13.032] Timer tick, asking Buildbucket for the build status
[20:22:13.240] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:13.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:37:0) after 1m0s
[20:23:13.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:37:0)
[20:23:13.275] Timer tick, asking Buildbucket for the build status
[20:23:13.474] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:13.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:38:0) after 1m0s
[20:24:13.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:38:0)
[20:24:13.537] Timer tick, asking Buildbucket for the build status
[20:24:14.032] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:14.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:39:0) after 1m0s
[20:25:14.080] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:39:0)
[20:25:14.080] Timer tick, asking Buildbucket for the build status
[20:25:14.590] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:14.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:40:0) after 1m0s
[20:26:14.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:40:0)
[20:26:14.639] Timer tick, asking Buildbucket for the build status
[20:26:14.829] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:14.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:41:0) after 1m0s
[20:27:14.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:41:0)
[20:27:14.858] Timer tick, asking Buildbucket for the build status
[20:27:15.738] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:15.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:42:0) after 1m0s
[20:28:15.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:42:0)
[20:28:15.717] Timer tick, asking Buildbucket for the build status
[20:28:15.849] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:15.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:43:0) after 1m0s
[20:29:16.081] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:43:0)
[20:29:16.081] Timer tick, asking Buildbucket for the build status
[20:29:16.429] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:16.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:44:0) after 1m0s
[20:30:16.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:44:0)
[20:30:16.523] Timer tick, asking Buildbucket for the build status
[20:30:16.759] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:16.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:45:0) after 1m0s
[20:31:17.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:45:0)
[20:31:17.368] Timer tick, asking Buildbucket for the build status
[20:31:19.098] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:19.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:46:0) after 1m0s
[20:32:19.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:46:0)
[20:32:19.533] Timer tick, asking Buildbucket for the build status
[20:32:20.109] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:20.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:47:0) after 1m0s
[20:33:20.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:47:0)
[20:33:20.225] Timer tick, asking Buildbucket for the build status
[20:33:20.364] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:20.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:48:0) after 1m0s
[20:34:20.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:48:0)
[20:34:20.527] Timer tick, asking Buildbucket for the build status
[20:34:20.829] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:20.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:49:0) after 1m0s
[20:35:21.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:49:0)
[20:35:21.014] Timer tick, asking Buildbucket for the build status
[20:35:21.492] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:21.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:50:0) after 1m0s
[20:36:21.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:50:0)
[20:36:21.622] Timer tick, asking Buildbucket for the build status
[20:36:21.789] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:21.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:51:0) after 1m0s
[20:37:21.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:51:0)
[20:37:21.811] Timer tick, asking Buildbucket for the build status
[20:37:21.939] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:21.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:52:0) after 1m0s
[20:38:22.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:52:0)
[20:38:22.064] Timer tick, asking Buildbucket for the build status
[20:38:22.330] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:22.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:53:0) after 1m0s
[20:39:22.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:53:0)
[20:39:22.505] Timer tick, asking Buildbucket for the build status
[20:39:22.870] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:22.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:54:0) after 1m0s
[20:40:22.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:54:0)
[20:40:22.950] Timer tick, asking Buildbucket for the build status
[20:40:23.089] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:23.090] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:55:0) after 1m0s
[20:41:23.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:55:0)
[20:41:23.178] Timer tick, asking Buildbucket for the build status
[20:41:23.361] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:23.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:56:0) after 1m0s
[20:42:23.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:56:0)
[20:42:23.418] Timer tick, asking Buildbucket for the build status
[20:42:23.997] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:23.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:57:0) after 1m0s
[20:43:24.040] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:57:0)
[20:43:24.040] Timer tick, asking Buildbucket for the build status
[20:43:24.213] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:24.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:58:0) after 1m0s
[20:44:24.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:58:0)
[20:44:24.282] Timer tick, asking Buildbucket for the build status
[20:44:24.638] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:24.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:59:0) after 1m0s
[20:45:24.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:59:0)
[20:45:24.731] Timer tick, asking Buildbucket for the build status
[20:45:24.870] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:24.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:60:0) after 1m0s
[20:46:24.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:60:0)
[20:46:24.999] Timer tick, asking Buildbucket for the build status
[20:46:25.127] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:25.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:61:0) after 1m0s
[20:47:25.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:61:0)
[20:47:25.182] Timer tick, asking Buildbucket for the build status
[20:47:25.344] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:25.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:62:0) after 1m0s
[20:48:25.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:62:0)
[20:48:25.344] Timer tick, asking Buildbucket for the build status
[20:48:25.482] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:25.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:63:0) after 1m0s
[20:49:25.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:63:0)
[20:49:25.523] Timer tick, asking Buildbucket for the build status
[20:49:25.715] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:25.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:64:0) after 1m0s
[20:50:25.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:64:0)
[20:50:25.701] Timer tick, asking Buildbucket for the build status
[20:50:25.875] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:25.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:65:0) after 1m0s
[20:51:25.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:65:0)
[20:51:25.948] Timer tick, asking Buildbucket for the build status
[20:51:26.120] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:26.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:66:0) after 1m0s
[20:52:26.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:66:0)
[20:52:26.155] Timer tick, asking Buildbucket for the build status
[20:52:26.292] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:26.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:67:0) after 1m0s
[20:53:26.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:67:0)
[20:53:26.304] Timer tick, asking Buildbucket for the build status
[20:53:26.470] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:26.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:68:0) after 1m0s
[20:54:26.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:68:0)
[20:54:26.495] Timer tick, asking Buildbucket for the build status
[20:54:26.636] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:26.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:69:0) after 1m0s
[20:55:26.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:69:0)
[20:55:26.641] Timer tick, asking Buildbucket for the build status
[20:55:26.767] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:26.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:70:0) after 1m0s
[20:56:26.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:70:0)
[20:56:26.793] Timer tick, asking Buildbucket for the build status
[20:56:27.255] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:27.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:71:0) after 1m0s
[20:57:27.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:71:0)
[20:57:27.375] Timer tick, asking Buildbucket for the build status
[20:57:27.932] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:27.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:72:0) after 1m0s
[20:58:27.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:72:0)
[20:58:27.957] Timer tick, asking Buildbucket for the build status
[20:58:28.178] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:28.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:73:0) after 1m0s
[20:59:28.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:73:0)
[20:59:28.201] Timer tick, asking Buildbucket for the build status
[20:59:28.317] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:28.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:74:0) after 1m0s
[21:00:28.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:74:0)
[21:00:28.363] Timer tick, asking Buildbucket for the build status
[21:00:28.607] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:28.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:75:0) after 1m0s
[21:01:28.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:75:0)
[21:01:28.662] Timer tick, asking Buildbucket for the build status
[21:01:28.930] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:28.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:76:0) after 1m0s
[21:02:28.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:76:0)
[21:02:28.955] Timer tick, asking Buildbucket for the build status
[21:02:29.124] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:29.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:77:0) after 1m0s
[21:03:29.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:77:0)
[21:03:29.159] Timer tick, asking Buildbucket for the build status
[21:03:29.508] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:29.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:78:0) after 1m0s
[21:04:29.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:78:0)
[21:04:29.625] Timer tick, asking Buildbucket for the build status
[21:04:29.746] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:29.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:79:0) after 1m0s
[21:05:29.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:79:0)
[21:05:29.857] Timer tick, asking Buildbucket for the build status
[21:05:30.006] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:30.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:80:0) after 1m0s
[21:06:30.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:80:0)
[21:06:30.150] Timer tick, asking Buildbucket for the build status
[21:06:30.410] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:30.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:81:0) after 1m0s
[21:07:30.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:81:0)
[21:07:30.470] Timer tick, asking Buildbucket for the build status
[21:07:30.834] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:30.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:82:0) after 1m0s
[21:08:30.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:82:0)
[21:08:30.876] Timer tick, asking Buildbucket for the build status
[21:08:31.043] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:31.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:83:0) after 1m0s
[21:09:31.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:83:0)
[21:09:31.095] Timer tick, asking Buildbucket for the build status
[21:09:31.231] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:31.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:84:0) after 1m0s
[21:10:31.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:84:0)
[21:10:31.325] Timer tick, asking Buildbucket for the build status
[21:10:31.447] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:31.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:85:0) after 1m0s
[21:11:31.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:85:0)
[21:11:31.482] Timer tick, asking Buildbucket for the build status
[21:11:31.667] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:31.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:86:0) after 1m0s
[21:12:31.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:86:0)
[21:12:31.791] Timer tick, asking Buildbucket for the build status
[21:12:32.191] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:32.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:87:0) after 1m0s
[21:13:32.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:87:0)
[21:13:32.333] Timer tick, asking Buildbucket for the build status
[21:13:32.462] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:32.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:88:0) after 1m0s
[21:14:32.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:88:0)
[21:14:32.527] Timer tick, asking Buildbucket for the build status
[21:14:32.824] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:32.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:89:0) after 1m0s
[21:15:32.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:89:0)
[21:15:32.853] Timer tick, asking Buildbucket for the build status
[21:15:33.052] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:33.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:90:0) after 1m0s
[21:16:33.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:90:0)
[21:16:33.066] Timer tick, asking Buildbucket for the build status
[21:16:33.181] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:33.181] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:91:0) after 1m0s
[21:17:33.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:91:0)
[21:17:33.205] Timer tick, asking Buildbucket for the build status
[21:17:33.483] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:33.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:92:0) after 1m0s
[21:18:33.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:92:0)
[21:18:33.506] Timer tick, asking Buildbucket for the build status
[21:18:33.932] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:33.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:93:0) after 1m0s
[21:19:33.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:93:0)
[21:19:33.982] Timer tick, asking Buildbucket for the build status
[21:19:34.448] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:34.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:94:0) after 1m0s
[21:20:34.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:94:0)
[21:20:34.481] Timer tick, asking Buildbucket for the build status
[21:20:34.841] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:34.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:95:0) after 1m0s
[21:21:34.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:95:0)
[21:21:34.971] Timer tick, asking Buildbucket for the build status
[21:21:35.105] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:35.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:96:0) after 1m0s
[21:22:35.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:96:0)
[21:22:35.107] Timer tick, asking Buildbucket for the build status
[21:22:35.557] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:35.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:97:0) after 1m0s
[21:23:35.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:97:0)
[21:23:35.605] Timer tick, asking Buildbucket for the build status
[21:23:35.769] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:35.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:98:0) after 1m0s
[21:24:35.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:98:0)
[21:24:35.768] Timer tick, asking Buildbucket for the build status
[21:24:35.893] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:35.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:99:0) after 1m0s
[21:25:36.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:99:0)
[21:25:36.086] Timer tick, asking Buildbucket for the build status
[21:25:36.254] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:36.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:100:0) after 1m0s
[21:26:36.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:100:0)
[21:26:36.289] Timer tick, asking Buildbucket for the build status
[21:26:36.772] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:36.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:101:0) after 1m0s
[21:27:36.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:101:0)
[21:27:36.838] Timer tick, asking Buildbucket for the build status
[21:27:37.096] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:37.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:102:0) after 1m0s
[21:28:37.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:102:0)
[21:28:37.122] Timer tick, asking Buildbucket for the build status
[21:28:37.307] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:37.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:103:0) after 1m0s
[21:29:37.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:103:0)
[21:29:37.385] Timer tick, asking Buildbucket for the build status
[21:29:37.589] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:37.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:104:0) after 1m0s
[21:30:37.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:104:0)
[21:30:37.599] Timer tick, asking Buildbucket for the build status
[21:30:38.401] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:38.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:105:0) after 1m0s
[21:31:38.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:105:0)
[21:31:38.436] Timer tick, asking Buildbucket for the build status
[21:31:38.604] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:38.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:106:0) after 1m0s
[21:32:38.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:106:0)
[21:32:38.641] Timer tick, asking Buildbucket for the build status
[21:32:38.778] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:38.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:107:0) after 1m0s
[21:33:38.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:107:0)
[21:33:38.833] Timer tick, asking Buildbucket for the build status
[21:33:39.283] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:39.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:108:0) after 1m0s
[21:34:39.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:108:0)
[21:34:39.334] Timer tick, asking Buildbucket for the build status
[21:34:39.630] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:39.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:109:0) after 1m0s
[21:35:39.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:109:0)
[21:35:39.653] Timer tick, asking Buildbucket for the build status
[21:35:39.787] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:39.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:110:0) after 1m0s
[21:36:39.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:110:0)
[21:36:39.860] Timer tick, asking Buildbucket for the build status
[21:36:40.041] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:40.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:111:0) after 1m0s
[21:37:40.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:111:0)
[21:37:40.074] Timer tick, asking Buildbucket for the build status
[21:37:40.434] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:40.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:112:0) after 1m0s
[21:38:40.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:112:0)
[21:38:40.466] Timer tick, asking Buildbucket for the build status
[21:38:40.652] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:40.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:113:0) after 1m0s
[21:39:40.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:113:0)
[21:39:40.680] Timer tick, asking Buildbucket for the build status
[21:39:40.784] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:40.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:114:0) after 1m0s
[21:40:40.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:114:0)
[21:40:40.805] Timer tick, asking Buildbucket for the build status
[21:40:40.952] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:40.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:115:0) after 1m0s
[21:41:40.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:115:0)
[21:41:40.985] Timer tick, asking Buildbucket for the build status
[21:41:41.102] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:41.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:116:0) after 1m0s
[21:42:41.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:116:0)
[21:42:41.179] Timer tick, asking Buildbucket for the build status
[21:42:41.474] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:41.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:117:0) after 1m0s
[21:43:41.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:117:0)
[21:43:41.597] Timer tick, asking Buildbucket for the build status
[21:43:41.765] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:41.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:118:0) after 1m0s
[21:44:41.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:118:0)
[21:44:41.852] Timer tick, asking Buildbucket for the build status
[21:44:42.192] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:42.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:119:0) after 1m0s
[21:45:42.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:119:0)
[21:45:42.216] Timer tick, asking Buildbucket for the build status
[21:45:42.719] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:42.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:120:0) after 1m0s
[21:46:42.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:120:0)
[21:46:42.726] Timer tick, asking Buildbucket for the build status
[21:46:42.839] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:42.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:121:0) after 1m0s
[21:47:42.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:121:0)
[21:47:42.868] Timer tick, asking Buildbucket for the build status
[21:47:42.988] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:42.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:122:0) after 1m0s
[21:48:43.015] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:122:0)
[21:48:43.015] Timer tick, asking Buildbucket for the build status
[21:48:43.454] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:43.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:123:0) after 1m0s
[21:49:43.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:123:0)
[21:49:43.479] Timer tick, asking Buildbucket for the build status
[21:49:46.209] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:46.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:124:0) after 1m0s
[21:50:46.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:124:0)
[21:50:46.301] Timer tick, asking Buildbucket for the build status
[21:50:46.747] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:46.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:125:0) after 1m0s
[21:51:46.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:125:0)
[21:51:46.973] Timer tick, asking Buildbucket for the build status
[21:51:47.084] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:47.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:126:0) after 1m0s
[21:52:47.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:126:0)
[21:52:47.356] Timer tick, asking Buildbucket for the build status
[21:52:47.491] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:47.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:127:0) after 1m0s
[21:53:47.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:127:0)
[21:53:47.561] Timer tick, asking Buildbucket for the build status
[21:53:48.439] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:48.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:128:0) after 1m0s
[21:54:48.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:128:0)
[21:54:48.492] Timer tick, asking Buildbucket for the build status
[21:54:48.602] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:48.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:129:0) after 1m0s
[21:55:48.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:129:0)
[21:55:48.675] Timer tick, asking Buildbucket for the build status
[21:55:48.943] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:48.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:130:0) after 1m0s
[21:56:49.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:130:0)
[21:56:49.032] Timer tick, asking Buildbucket for the build status
[21:56:49.319] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:49.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:131:0) after 1m0s
[21:57:49.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:131:0)
[21:57:49.444] Timer tick, asking Buildbucket for the build status
[21:57:49.573] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:49.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:132:0) after 1m0s
[21:58:49.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:132:0)
[21:58:49.599] Timer tick, asking Buildbucket for the build status
[21:58:49.709] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:49.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:133:0) after 1m0s
[21:59:49.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:133:0)
[21:59:49.906] Timer tick, asking Buildbucket for the build status
[21:59:50.109] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:50.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:134:0) after 1m0s
[22:00:50.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:134:0)
[22:00:50.119] Timer tick, asking Buildbucket for the build status
[22:00:50.269] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:50.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:135:0) after 1m0s
[22:01:50.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:135:0)
[22:01:50.301] Timer tick, asking Buildbucket for the build status
[22:01:50.419] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:50.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:136:0) after 1m0s
[22:02:50.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:136:0)
[22:02:50.461] Timer tick, asking Buildbucket for the build status
[22:02:50.644] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:50.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:137:0) after 1m0s
[22:03:50.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:137:0)
[22:03:50.676] Timer tick, asking Buildbucket for the build status
[22:03:50.974] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:50.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:138:0) after 1m0s
[22:04:51.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:138:0)
[22:04:51.058] Timer tick, asking Buildbucket for the build status
[22:04:51.264] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:51.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:139:0) after 1m0s
[22:05:51.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:139:0)
[22:05:51.444] Timer tick, asking Buildbucket for the build status
[22:05:51.520] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:51.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:140:0) after 1m0s
[22:06:51.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:140:0)
[22:06:51.581] Timer tick, asking Buildbucket for the build status
[22:06:51.686] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:51.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:141:0) after 1m0s
[22:07:51.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:141:0)
[22:07:51.703] Timer tick, asking Buildbucket for the build status
[22:07:52.211] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:52.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:142:0) after 1m0s
[22:08:52.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:142:0)
[22:08:52.276] Timer tick, asking Buildbucket for the build status
[22:08:52.424] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:52.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:143:0) after 1m0s
[22:09:52.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:143:0)
[22:09:52.455] Timer tick, asking Buildbucket for the build status
[22:09:52.546] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:52.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:144:0) after 1m0s
[22:10:52.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:144:0)
[22:10:52.712] Timer tick, asking Buildbucket for the build status
[22:10:53.074] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:53.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:145:0) after 1m0s
[22:11:53.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:145:0)
[22:11:53.157] Timer tick, asking Buildbucket for the build status
[22:11:53.282] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:53.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:146:0) after 1m0s
[22:12:53.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:146:0)
[22:12:53.312] Timer tick, asking Buildbucket for the build status
[22:12:53.436] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:53.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:147:0) after 1m0s
[22:13:53.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:147:0)
[22:13:53.483] Timer tick, asking Buildbucket for the build status
[22:13:53.840] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:53.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:148:0) after 1m0s
[22:14:53.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:148:0)
[22:14:53.976] Timer tick, asking Buildbucket for the build status
[22:14:54.367] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:54.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:149:0) after 1m0s
[22:15:54.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:149:0)
[22:15:54.495] Timer tick, asking Buildbucket for the build status
[22:15:54.796] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:54.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:150:0) after 1m0s
[22:16:54.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:150:0)
[22:16:54.809] Timer tick, asking Buildbucket for the build status
[22:16:54.923] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:54.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:151:0) after 1m0s
[22:17:54.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:151:0)
[22:17:54.951] Timer tick, asking Buildbucket for the build status
[22:17:55.044] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:55.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:152:0) after 1m0s
[22:18:55.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:152:0)
[22:18:55.089] Timer tick, asking Buildbucket for the build status
[22:18:55.251] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:55.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:153:0) after 1m0s
[22:19:55.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:153:0)
[22:19:55.437] Timer tick, asking Buildbucket for the build status
[22:19:55.574] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:55.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:154:0) after 1m0s
[22:20:55.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:154:0)
[22:20:55.566] Timer tick, asking Buildbucket for the build status
[22:20:55.700] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:55.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:155:0) after 1m0s
[22:21:55.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:155:0)
[22:21:55.935] Timer tick, asking Buildbucket for the build status
[22:21:56.557] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:56.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:156:0) after 1m0s
[22:22:56.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:156:0)
[22:22:56.797] Timer tick, asking Buildbucket for the build status
[22:22:57.267] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:57.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:157:0) after 1m0s
[22:23:57.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:157:0)
[22:23:57.477] Timer tick, asking Buildbucket for the build status
[22:23:57.730] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:57.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:158:0) after 1m0s
[22:24:57.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:158:0)
[22:24:57.775] Timer tick, asking Buildbucket for the build status
[22:24:57.883] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:57.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:159:0) after 1m0s
[22:25:58.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:159:0)
[22:25:58.032] Timer tick, asking Buildbucket for the build status
[22:25:58.241] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:58.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:160:0) after 1m0s
[22:26:58.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:160:0)
[22:26:58.388] Timer tick, asking Buildbucket for the build status
[22:26:58.592] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:58.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:161:0) after 1m0s
[22:27:58.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:161:0)
[22:27:58.710] Timer tick, asking Buildbucket for the build status
[22:27:58.825] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:58.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:162:0) after 1m0s
[22:28:58.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:162:0)
[22:28:58.824] Timer tick, asking Buildbucket for the build status
[22:28:59.084] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:59.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:163:0) after 1m0s
[22:29:59.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:163:0)
[22:29:59.112] Timer tick, asking Buildbucket for the build status
[22:29:59.270] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:59.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:164:0) after 1m0s
[22:30:59.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:164:0)
[22:30:59.294] Timer tick, asking Buildbucket for the build status
[22:31:00.096] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:00.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:165:0) after 1m0s
[22:32:00.170] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:165:0)
[22:32:00.170] Timer tick, asking Buildbucket for the build status
[22:32:00.300] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:00.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:166:0) after 1m0s
[22:33:00.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:166:0)
[22:33:00.380] Timer tick, asking Buildbucket for the build status
[22:33:00.489] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:00.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:167:0) after 1m0s
[22:34:00.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:167:0)
[22:34:00.586] Timer tick, asking Buildbucket for the build status
[22:34:01.060] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:01.060] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:168:0) after 1m0s
[22:35:01.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:168:0)
[22:35:01.122] Timer tick, asking Buildbucket for the build status
[22:35:01.277] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:01.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:169:0) after 1m0s
[22:36:01.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:169:0)
[22:36:01.451] Timer tick, asking Buildbucket for the build status
[22:36:01.606] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:01.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:170:0) after 1m0s
[22:37:01.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:170:0)
[22:37:01.648] Timer tick, asking Buildbucket for the build status
[22:37:01.795] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:01.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:171:0) after 1m0s
[22:38:01.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:171:0)
[22:38:01.829] Timer tick, asking Buildbucket for the build status
[22:38:02.162] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:02.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:172:0) after 1m0s
[22:39:02.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:172:0)
[22:39:02.268] Timer tick, asking Buildbucket for the build status
[22:39:02.407] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:02.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:173:0) after 1m0s
[22:40:02.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:173:0)
[22:40:02.451] Timer tick, asking Buildbucket for the build status
[22:40:02.733] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:02.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:174:0) after 1m0s
[22:41:02.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:174:0)
[22:41:02.777] Timer tick, asking Buildbucket for the build status
[22:41:03.273] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:03.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:175:0) after 1m0s
[22:42:03.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:175:0)
[22:42:03.326] Timer tick, asking Buildbucket for the build status
[22:42:04.368] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:04.368] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:176:0) after 1m0s
[22:43:04.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:176:0)
[22:43:04.459] Timer tick, asking Buildbucket for the build status
[22:43:04.607] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:04.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:177:0) after 1m0s
[22:44:04.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:177:0)
[22:44:04.646] Timer tick, asking Buildbucket for the build status
[22:44:04.820] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:04.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:178:0) after 1m0s
[22:45:04.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:178:0)
[22:45:04.868] Timer tick, asking Buildbucket for the build status
[22:45:05.011] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:05.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:179:0) after 1m0s
[22:46:05.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:179:0)
[22:46:05.526] Timer tick, asking Buildbucket for the build status
[22:46:05.925] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:05.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:180:0) after 1m0s
[22:47:05.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:180:0)
[22:47:05.958] Timer tick, asking Buildbucket for the build status
[22:47:06.218] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:06.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:181:0) after 1m0s
[22:48:06.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:181:0)
[22:48:06.295] Timer tick, asking Buildbucket for the build status
[22:48:06.446] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:06.446] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:182:0) after 1m0s
[22:49:06.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:182:0)
[22:49:06.603] Timer tick, asking Buildbucket for the build status
[22:49:06.724] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:06.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:183:0) after 1m0s
[22:50:06.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:183:0)
[22:50:06.756] Timer tick, asking Buildbucket for the build status
[22:50:07.037] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:07.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:184:0) after 1m0s
[22:51:07.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:184:0)
[22:51:07.073] Timer tick, asking Buildbucket for the build status
[22:51:07.203] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:07.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:185:0) after 1m0s
[22:52:07.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:185:0)
[22:52:07.203] Timer tick, asking Buildbucket for the build status
[22:52:07.427] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:07.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:186:0) after 1m0s
[22:53:07.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:186:0)
[22:53:07.462] Timer tick, asking Buildbucket for the build status
[22:53:07.600] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:07.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:187:0) after 1m0s
[22:54:07.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:187:0)
[22:54:07.626] Timer tick, asking Buildbucket for the build status
[22:54:10.093] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:10.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:188:0) after 1m0s
[22:55:10.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:188:0)
[22:55:10.172] Timer tick, asking Buildbucket for the build status
[22:55:10.278] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:10.278] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:189:0) after 1m0s
[22:56:10.310] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:189:0)
[22:56:10.310] Timer tick, asking Buildbucket for the build status
[22:56:10.537] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:10.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:190:0) after 1m0s
[22:57:10.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:190:0)
[22:57:10.699] Timer tick, asking Buildbucket for the build status
[22:57:11.479] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:11.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:191:0) after 1m0s
[22:58:11.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:191:0)
[22:58:11.720] Timer tick, asking Buildbucket for the build status
[22:58:11.859] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:11.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:192:0) after 1m0s
[22:59:12.081] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:192:0)
[22:59:12.081] Timer tick, asking Buildbucket for the build status
[22:59:12.667] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:12.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:193:0) after 1m0s
[23:00:12.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:193:0)
[23:00:12.738] Timer tick, asking Buildbucket for the build status
[23:00:13.316] Build 8882652697921631120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:13.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048082760272989696:194:0) after 1m0s
[23:00:48.437] Received PubSub notification, asking Buildbucket for the build status
[23:00:48.529] Build 8882652697921631120: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:00:48.529] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1587250847467362",
    "created_by": "project:infra",
    "created_ts": "1587239282643757",
    "id": "8882652697921631120",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4118.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"bc01ab73-b980-40bb-92d2-f1735c3ef577\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4118.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\": \"84.0.4118.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"bc01ab73-b980-40bb-92d2-f1735c3ef577\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-8zad\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"84.0.4118.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-8zad\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"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\": [\"4985-2a273fe\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1587240755848474",
    "status": "COMPLETED",
    "status_changed_ts": "1587250847983250",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9048082760272989696",
      "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/8882652697921631120/+/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:4ba7a6f2f5c4e110",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1587250848035278",
    "url": "https://ci.chromium.org/b/8882652697921631120",
    "utcnow_ts": "1587250848521271"
  }
}
[23:00:48.530] Invocation finished in 3h12m47.512906568s with status SUCCEEDED