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

• parent_buildername:publish_tarball
• user_agent:recipe

[08:33:16.153] New invocation is queued and will start shortly
[08:33:16.153] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:33:17.391] Starting the invocation (attempt 1)
[08:33:17.427] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:33:17.427] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:33:17.428] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9028103282174563168",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"89.0.4336.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"f32768fd-9b95-4e4e-9ef2-9b25d201f23e\",\"title\":\"publish_tarball/0\"}]},\"version\":\"89.0.4336.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:9028103282174563168",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[08:33:17.963] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1606293197517496",
    "id": "8862673220078517040",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"89.0.4336.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f32768fd-9b95-4e4e-9ef2-9b25d201f23e\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"89.0.4336.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1606293197694513",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9028103282174563168",
      "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/8862673220078517040/+/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": "1606293197694672",
    "url": "https://ci.chromium.org/b/8862673220078517040",
    "utcnow_ts": "1606293197957374"
  }
}
[08:33:17.963] Task URL: https://ci.chromium.org/b/8862673220078517040
[08:33:17.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:2:0) after 1m0s
[08:33:25.208] Received PubSub notification, asking Buildbucket for the build status
[08:33:25.276] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:17.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:2:0)
[08:34:17.957] Timer tick, asking Buildbucket for the build status
[08:34:19.611] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:19.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:4:0) after 1m0s
[08:35:19.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:4:0)
[08:35:19.667] Timer tick, asking Buildbucket for the build status
[08:35:19.754] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:19.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:5:0) after 1m0s
[08:36:19.888] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:5:0)
[08:36:19.888] Timer tick, asking Buildbucket for the build status
[08:36:19.981] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:19.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:6:0) after 1m0s
[08:37:20.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:6:0)
[08:37:20.027] Timer tick, asking Buildbucket for the build status
[08:37:20.097] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:20.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:7:0) after 1m0s
[08:38:20.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:7:0)
[08:38:20.125] Timer tick, asking Buildbucket for the build status
[08:38:20.301] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:20.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:8:0) after 1m0s
[08:39:20.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:8:0)
[08:39:20.378] Timer tick, asking Buildbucket for the build status
[08:39:20.505] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:20.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:9:0) after 1m0s
[08:40:20.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:9:0)
[08:40:20.622] Timer tick, asking Buildbucket for the build status
[08:40:20.687] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:20.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:10:0) after 1m0s
[08:41:20.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:10:0)
[08:41:20.692] Timer tick, asking Buildbucket for the build status
[08:41:20.939] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:20.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:11:0) after 1m0s
[08:42:21.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:11:0)
[08:42:21.057] Timer tick, asking Buildbucket for the build status
[08:42:21.351] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:21.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:12:0) after 1m0s
[08:43:21.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:12:0)
[08:43:21.404] Timer tick, asking Buildbucket for the build status
[08:43:21.516] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:21.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:13:0) after 1m0s
[08:44:21.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:13:0)
[08:44:21.589] Timer tick, asking Buildbucket for the build status
[08:44:21.647] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:21.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:14:0) after 1m0s
[08:45:21.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:14:0)
[08:45:21.654] Timer tick, asking Buildbucket for the build status
[08:45:21.726] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:21.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:15:0) after 1m0s
[08:46:21.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:15:0)
[08:46:21.711] Timer tick, asking Buildbucket for the build status
[08:46:21.797] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:21.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:16:0) after 1m0s
[08:47:21.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:16:0)
[08:47:21.817] Timer tick, asking Buildbucket for the build status
[08:47:22.058] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:22.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:17:0) after 1m0s
[08:48:22.080] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:17:0)
[08:48:22.080] Timer tick, asking Buildbucket for the build status
[08:48:22.187] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:22.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:18:0) after 1m0s
[08:49:22.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:18:0)
[08:49:22.213] Timer tick, asking Buildbucket for the build status
[08:49:22.483] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:22.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:19:0) after 1m0s
[08:50:22.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:19:0)
[08:50:22.505] Timer tick, asking Buildbucket for the build status
[08:50:22.574] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:22.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:20:0) after 1m0s
[08:51:22.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:20:0)
[08:51:22.601] Timer tick, asking Buildbucket for the build status
[08:51:22.737] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:22.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:21:0) after 1m0s
[08:52:22.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:21:0)
[08:52:22.794] Timer tick, asking Buildbucket for the build status
[08:52:22.861] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:22.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:22:0) after 1m0s
[08:53:22.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:22:0)
[08:53:22.841] Timer tick, asking Buildbucket for the build status
[08:53:22.987] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:22.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:23:0) after 1m0s
[08:54:23.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:23:0)
[08:54:23.018] Timer tick, asking Buildbucket for the build status
[08:54:23.144] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:23.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:24:0) after 1m0s
[08:55:23.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:24:0)
[08:55:23.264] Timer tick, asking Buildbucket for the build status
[08:55:23.336] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:23.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:25:0) after 1m0s
[08:56:23.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:25:0)
[08:56:23.359] Timer tick, asking Buildbucket for the build status
[08:56:23.430] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:23.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:26:0) after 1m0s
[08:57:23.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:26:0)
[08:57:23.454] Timer tick, asking Buildbucket for the build status
[08:57:23.532] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:23.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:27:0) after 1m0s
[08:58:23.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:27:0)
[08:58:23.573] Timer tick, asking Buildbucket for the build status
[08:58:23.708] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:23.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:28:0) after 1m0s
[08:59:23.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:28:0)
[08:59:23.729] Timer tick, asking Buildbucket for the build status
[08:59:23.798] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:23.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:29:0) after 1m0s
[09:00:23.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:29:0)
[09:00:23.804] Timer tick, asking Buildbucket for the build status
[09:00:23.885] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:23.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:30:0) after 1m0s
[09:01:23.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:30:0)
[09:01:23.918] Timer tick, asking Buildbucket for the build status
[09:01:23.977] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:23.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:31:0) after 1m0s
[09:02:24.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:31:0)
[09:02:24.119] Timer tick, asking Buildbucket for the build status
[09:02:24.206] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:24.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:32:0) after 1m0s
[09:03:24.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:32:0)
[09:03:24.308] Timer tick, asking Buildbucket for the build status
[09:03:24.414] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:24.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:33:0) after 1m0s
[09:04:24.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:33:0)
[09:04:24.438] Timer tick, asking Buildbucket for the build status
[09:04:24.738] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:24.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:34:0) after 1m0s
[09:05:24.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:34:0)
[09:05:24.773] Timer tick, asking Buildbucket for the build status
[09:05:24.838] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:24.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:35:0) after 1m0s
[09:06:24.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:35:0)
[09:06:24.823] Timer tick, asking Buildbucket for the build status
[09:06:24.954] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:24.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:36:0) after 1m0s
[09:07:24.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:36:0)
[09:07:24.929] Timer tick, asking Buildbucket for the build status
[09:07:24.995] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:24.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:37:0) after 1m0s
[09:08:25.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:37:0)
[09:08:25.063] Timer tick, asking Buildbucket for the build status
[09:08:25.212] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:25.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:38:0) after 1m0s
[09:09:25.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:38:0)
[09:09:25.236] Timer tick, asking Buildbucket for the build status
[09:09:25.316] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:25.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:39:0) after 1m0s
[09:10:25.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:39:0)
[09:10:25.413] Timer tick, asking Buildbucket for the build status
[09:10:25.467] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:25.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:40:0) after 1m0s
[09:11:25.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:40:0)
[09:11:25.496] Timer tick, asking Buildbucket for the build status
[09:11:25.725] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:25.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:41:0) after 1m0s
[09:12:25.826] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:41:0)
[09:12:25.826] Timer tick, asking Buildbucket for the build status
[09:12:25.879] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:25.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:42:0) after 1m0s
[09:13:26.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:42:0)
[09:13:26.125] Timer tick, asking Buildbucket for the build status
[09:13:26.232] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:26.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:43:0) after 1m0s
[09:14:26.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:43:0)
[09:14:26.386] Timer tick, asking Buildbucket for the build status
[09:14:26.441] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:26.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:44:0) after 1m0s
[09:15:26.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:44:0)
[09:15:26.466] Timer tick, asking Buildbucket for the build status
[09:15:26.523] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:26.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:45:0) after 1m0s
[09:16:26.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:45:0)
[09:16:26.544] Timer tick, asking Buildbucket for the build status
[09:16:26.610] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:26.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:46:0) after 1m0s
[09:17:26.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:46:0)
[09:17:26.700] Timer tick, asking Buildbucket for the build status
[09:17:26.867] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:26.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:47:0) after 1m0s
[09:18:26.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:47:0)
[09:18:26.937] Timer tick, asking Buildbucket for the build status
[09:18:27.053] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:27.053] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:48:0) after 1m0s
[09:19:27.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:48:0)
[09:19:27.108] Timer tick, asking Buildbucket for the build status
[09:19:27.171] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:27.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:49:0) after 1m0s
[09:20:27.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:49:0)
[09:20:27.224] Timer tick, asking Buildbucket for the build status
[09:20:27.284] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:27.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:50:0) after 1m0s
[09:21:27.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:50:0)
[09:21:27.355] Timer tick, asking Buildbucket for the build status
[09:21:27.569] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:27.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:51:0) after 1m0s
[09:22:27.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:51:0)
[09:22:27.633] Timer tick, asking Buildbucket for the build status
[09:22:27.741] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:27.741] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:52:0) after 1m0s
[09:23:27.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:52:0)
[09:23:27.830] Timer tick, asking Buildbucket for the build status
[09:23:27.927] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:27.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:53:0) after 1m0s
[09:24:27.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:53:0)
[09:24:27.950] Timer tick, asking Buildbucket for the build status
[09:24:28.009] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:28.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:54:0) after 1m0s
[09:25:28.332] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:54:0)
[09:25:28.332] Timer tick, asking Buildbucket for the build status
[09:25:28.400] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:28.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:55:0) after 1m0s
[09:26:28.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:55:0)
[09:26:28.727] Timer tick, asking Buildbucket for the build status
[09:26:28.781] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:28.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:56:0) after 1m0s
[09:27:29.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:56:0)
[09:27:29.071] Timer tick, asking Buildbucket for the build status
[09:27:29.128] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:29.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:57:0) after 1m0s
[09:28:29.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:57:0)
[09:28:29.298] Timer tick, asking Buildbucket for the build status
[09:28:29.402] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:29.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:58:0) after 1m0s
[09:29:29.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:58:0)
[09:29:29.614] Timer tick, asking Buildbucket for the build status
[09:29:29.726] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:29.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:59:0) after 1m0s
[09:30:30.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:59:0)
[09:30:30.998] Timer tick, asking Buildbucket for the build status
[09:30:31.067] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:31.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:60:0) after 1m0s
[09:31:31.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:60:0)
[09:31:31.137] Timer tick, asking Buildbucket for the build status
[09:31:31.243] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:31.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:61:0) after 1m0s
[09:32:31.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:61:0)
[09:32:31.366] Timer tick, asking Buildbucket for the build status
[09:32:31.432] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:31.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:62:0) after 1m0s
[09:33:31.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:62:0)
[09:33:31.518] Timer tick, asking Buildbucket for the build status
[09:33:31.614] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:31.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:63:0) after 1m0s
[09:34:31.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:63:0)
[09:34:31.687] Timer tick, asking Buildbucket for the build status
[09:34:31.926] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:31.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:64:0) after 1m0s
[09:35:31.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:64:0)
[09:35:31.921] Timer tick, asking Buildbucket for the build status
[09:35:32.004] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:32.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:65:0) after 1m0s
[09:36:32.081] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:65:0)
[09:36:32.081] Timer tick, asking Buildbucket for the build status
[09:36:32.416] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:32.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:66:0) after 1m0s
[09:37:32.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:66:0)
[09:37:32.514] Timer tick, asking Buildbucket for the build status
[09:37:33.425] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:33.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:67:0) after 1m0s
[09:38:33.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:67:0)
[09:38:33.490] Timer tick, asking Buildbucket for the build status
[09:38:33.601] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:33.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:68:0) after 1m0s
[09:39:33.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:68:0)
[09:39:33.625] Timer tick, asking Buildbucket for the build status
[09:39:33.704] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:33.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:69:0) after 1m0s
[09:40:33.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:69:0)
[09:40:33.798] Timer tick, asking Buildbucket for the build status
[09:40:33.873] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:33.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:70:0) after 1m0s
[09:41:33.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:70:0)
[09:41:33.896] Timer tick, asking Buildbucket for the build status
[09:41:33.960] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:33.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:71:0) after 1m0s
[09:42:34.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:71:0)
[09:42:34.007] Timer tick, asking Buildbucket for the build status
[09:42:34.058] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:34.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:72:0) after 1m0s
[09:43:34.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:72:0)
[09:43:34.037] Timer tick, asking Buildbucket for the build status
[09:43:34.126] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:34.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:73:0) after 1m0s
[09:44:34.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:73:0)
[09:44:34.156] Timer tick, asking Buildbucket for the build status
[09:44:34.224] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:34.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:74:0) after 1m0s
[09:45:34.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:74:0)
[09:45:34.287] Timer tick, asking Buildbucket for the build status
[09:45:34.341] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:34.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:75:0) after 1m0s
[09:46:34.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:75:0)
[09:46:34.451] Timer tick, asking Buildbucket for the build status
[09:46:34.519] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:34.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:76:0) after 1m0s
[09:47:34.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:76:0)
[09:47:34.525] Timer tick, asking Buildbucket for the build status
[09:47:34.592] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:34.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:77:0) after 1m0s
[09:48:34.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:77:0)
[09:48:34.628] Timer tick, asking Buildbucket for the build status
[09:48:34.802] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:34.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:78:0) after 1m0s
[09:49:34.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:78:0)
[09:49:34.872] Timer tick, asking Buildbucket for the build status
[09:49:34.945] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:34.945] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:79:0) after 1m0s
[09:50:35.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:79:0)
[09:50:35.055] Timer tick, asking Buildbucket for the build status
[09:50:35.126] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:35.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:80:0) after 1m0s
[09:51:35.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:80:0)
[09:51:35.162] Timer tick, asking Buildbucket for the build status
[09:51:35.648] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:35.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:81:0) after 1m0s
[09:52:35.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:81:0)
[09:52:35.672] Timer tick, asking Buildbucket for the build status
[09:52:35.725] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:35.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:82:0) after 1m0s
[09:53:35.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:82:0)
[09:53:35.764] Timer tick, asking Buildbucket for the build status
[09:53:35.872] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:35.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:83:0) after 1m0s
[09:54:35.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:83:0)
[09:54:35.905] Timer tick, asking Buildbucket for the build status
[09:54:35.965] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:35.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:84:0) after 1m0s
[09:55:35.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:84:0)
[09:55:35.991] Timer tick, asking Buildbucket for the build status
[09:55:36.355] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:36.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:85:0) after 1m0s
[09:56:36.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:85:0)
[09:56:36.409] Timer tick, asking Buildbucket for the build status
[09:56:36.477] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:36.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:86:0) after 1m0s
[09:57:36.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:86:0)
[09:57:36.607] Timer tick, asking Buildbucket for the build status
[09:57:36.901] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:36.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:87:0) after 1m0s
[09:58:37.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:87:0)
[09:58:37.095] Timer tick, asking Buildbucket for the build status
[09:58:37.207] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:37.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:88:0) after 1m0s
[09:59:37.360] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:88:0)
[09:59:37.360] Timer tick, asking Buildbucket for the build status
[09:59:37.731] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:37.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:89:0) after 1m0s
[10:00:37.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:89:0)
[10:00:37.924] Timer tick, asking Buildbucket for the build status
[10:00:38.018] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:38.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:90:0) after 1m0s
[10:01:38.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:90:0)
[10:01:38.057] Timer tick, asking Buildbucket for the build status
[10:01:38.120] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:38.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:91:0) after 1m0s
[10:02:38.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:91:0)
[10:02:38.138] Timer tick, asking Buildbucket for the build status
[10:02:38.368] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:38.368] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:92:0) after 1m0s
[10:03:38.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:92:0)
[10:03:38.382] Timer tick, asking Buildbucket for the build status
[10:03:38.761] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:38.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:93:0) after 1m0s
[10:04:38.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:93:0)
[10:04:38.830] Timer tick, asking Buildbucket for the build status
[10:04:38.901] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:38.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:94:0) after 1m0s
[10:05:39.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:94:0)
[10:05:39.014] Timer tick, asking Buildbucket for the build status
[10:05:39.074] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:39.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:95:0) after 1m0s
[10:06:39.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:95:0)
[10:06:39.226] Timer tick, asking Buildbucket for the build status
[10:06:39.286] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:39.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:96:0) after 1m0s
[10:07:39.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:96:0)
[10:07:39.256] Timer tick, asking Buildbucket for the build status
[10:07:39.527] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:39.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:97:0) after 1m0s
[10:08:40.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:97:0)
[10:08:40.744] Timer tick, asking Buildbucket for the build status
[10:08:40.857] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:40.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:98:0) after 1m0s
[10:09:40.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:98:0)
[10:09:40.875] Timer tick, asking Buildbucket for the build status
[10:09:41.106] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:41.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:99:0) after 1m0s
[10:10:41.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:99:0)
[10:10:41.208] Timer tick, asking Buildbucket for the build status
[10:10:41.324] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:41.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:100:0) after 1m0s
[10:11:41.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:100:0)
[10:11:41.349] Timer tick, asking Buildbucket for the build status
[10:11:41.744] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:41.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:101:0) after 1m0s
[10:12:41.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:101:0)
[10:12:41.794] Timer tick, asking Buildbucket for the build status
[10:12:41.873] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:41.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:102:0) after 1m0s
[10:13:41.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:102:0)
[10:13:41.874] Timer tick, asking Buildbucket for the build status
[10:13:41.989] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:41.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:103:0) after 1m0s
[10:14:42.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:103:0)
[10:14:42.065] Timer tick, asking Buildbucket for the build status
[10:14:42.153] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:42.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:104:0) after 1m0s
[10:15:42.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:104:0)
[10:15:42.133] Timer tick, asking Buildbucket for the build status
[10:15:42.233] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:42.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:105:0) after 1m0s
[10:16:42.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:105:0)
[10:16:42.301] Timer tick, asking Buildbucket for the build status
[10:16:42.391] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:42.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:106:0) after 1m0s
[10:17:42.504] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:106:0)
[10:17:42.504] Timer tick, asking Buildbucket for the build status
[10:17:42.571] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:42.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:107:0) after 1m0s
[10:18:42.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:107:0)
[10:18:42.597] Timer tick, asking Buildbucket for the build status
[10:18:43.141] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:43.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:108:0) after 1m0s
[10:19:43.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:108:0)
[10:19:43.169] Timer tick, asking Buildbucket for the build status
[10:19:43.235] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:43.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:109:0) after 1m0s
[10:20:43.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:109:0)
[10:20:43.357] Timer tick, asking Buildbucket for the build status
[10:20:43.427] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:43.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:110:0) after 1m0s
[10:21:43.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:110:0)
[10:21:43.410] Timer tick, asking Buildbucket for the build status
[10:21:43.476] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:43.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:111:0) after 1m0s
[10:22:43.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:111:0)
[10:22:43.546] Timer tick, asking Buildbucket for the build status
[10:22:43.622] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:43.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:112:0) after 1m0s
[10:23:43.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:112:0)
[10:23:43.672] Timer tick, asking Buildbucket for the build status
[10:23:43.904] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:43.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:113:0) after 1m0s
[10:24:43.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:113:0)
[10:24:43.976] Timer tick, asking Buildbucket for the build status
[10:24:44.424] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:44.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:114:0) after 1m0s
[10:25:44.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:114:0)
[10:25:44.492] Timer tick, asking Buildbucket for the build status
[10:25:44.566] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:44.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:115:0) after 1m0s
[10:26:44.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:115:0)
[10:26:44.615] Timer tick, asking Buildbucket for the build status
[10:26:44.685] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:44.685] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:116:0) after 1m0s
[10:27:44.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:116:0)
[10:27:44.707] Timer tick, asking Buildbucket for the build status
[10:27:44.765] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:44.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:117:0) after 1m0s
[10:28:44.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:117:0)
[10:28:44.877] Timer tick, asking Buildbucket for the build status
[10:28:45.214] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:45.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:118:0) after 1m0s
[10:29:45.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:118:0)
[10:29:45.240] Timer tick, asking Buildbucket for the build status
[10:29:45.300] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:45.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:119:0) after 1m0s
[10:30:45.326] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:119:0)
[10:30:45.326] Timer tick, asking Buildbucket for the build status
[10:30:45.388] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:45.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:120:0) after 1m0s
[10:31:45.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:120:0)
[10:31:45.437] Timer tick, asking Buildbucket for the build status
[10:31:49.026] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:49.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:121:0) after 1m0s
[10:32:49.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:121:0)
[10:32:49.203] Timer tick, asking Buildbucket for the build status
[10:32:49.329] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:49.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:122:0) after 1m0s
[10:33:49.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:122:0)
[10:33:49.396] Timer tick, asking Buildbucket for the build status
[10:33:49.548] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:49.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:123:0) after 1m0s
[10:34:49.663] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:123:0)
[10:34:49.663] Timer tick, asking Buildbucket for the build status
[10:34:49.723] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:49.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:124:0) after 1m0s
[10:35:49.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:124:0)
[10:35:49.750] Timer tick, asking Buildbucket for the build status
[10:35:49.913] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:49.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:125:0) after 1m0s
[10:36:49.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:125:0)
[10:36:49.970] Timer tick, asking Buildbucket for the build status
[10:36:50.069] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:50.069] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:126:0) after 1m0s
[10:37:50.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:126:0)
[10:37:50.095] Timer tick, asking Buildbucket for the build status
[10:37:50.447] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:50.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:127:0) after 1m0s
[10:38:50.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:127:0)
[10:38:50.478] Timer tick, asking Buildbucket for the build status
[10:38:50.612] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:50.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:128:0) after 1m0s
[10:39:50.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:128:0)
[10:39:50.670] Timer tick, asking Buildbucket for the build status
[10:39:51.825] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:51.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:129:0) after 1m0s
[10:40:51.855] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:129:0)
[10:40:51.855] Timer tick, asking Buildbucket for the build status
[10:40:51.957] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:51.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:130:0) after 1m0s
[10:41:51.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:130:0)
[10:41:51.998] Timer tick, asking Buildbucket for the build status
[10:41:52.068] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:52.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:131:0) after 1m0s
[10:42:52.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:131:0)
[10:42:52.161] Timer tick, asking Buildbucket for the build status
[10:42:52.264] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:52.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:132:0) after 1m0s
[10:43:52.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:132:0)
[10:43:52.321] Timer tick, asking Buildbucket for the build status
[10:43:52.604] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:52.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:133:0) after 1m0s
[10:44:52.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:133:0)
[10:44:52.713] Timer tick, asking Buildbucket for the build status
[10:44:53.175] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:53.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:134:0) after 1m0s
[10:45:53.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:134:0)
[10:45:53.199] Timer tick, asking Buildbucket for the build status
[10:45:53.296] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:53.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:135:0) after 1m0s
[10:46:53.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:135:0)
[10:46:53.383] Timer tick, asking Buildbucket for the build status
[10:46:53.437] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:53.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:136:0) after 1m0s
[10:47:53.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:136:0)
[10:47:53.511] Timer tick, asking Buildbucket for the build status
[10:47:53.664] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:53.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:137:0) after 1m0s
[10:48:53.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:137:0)
[10:48:53.698] Timer tick, asking Buildbucket for the build status
[10:48:53.868] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:53.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:138:0) after 1m0s
[10:49:53.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:138:0)
[10:49:53.845] Timer tick, asking Buildbucket for the build status
[10:49:53.904] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:53.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:139:0) after 1m0s
[10:50:53.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:139:0)
[10:50:53.933] Timer tick, asking Buildbucket for the build status
[10:50:53.994] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:53.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:140:0) after 1m0s
[10:51:54.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:140:0)
[10:51:54.021] Timer tick, asking Buildbucket for the build status
[10:51:54.405] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:54.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:141:0) after 1m0s
[10:52:54.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:141:0)
[10:52:54.486] Timer tick, asking Buildbucket for the build status
[10:52:54.756] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:54.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:142:0) after 1m0s
[10:53:54.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:142:0)
[10:53:54.783] Timer tick, asking Buildbucket for the build status
[10:53:55.029] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:55.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:143:0) after 1m0s
[10:54:55.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:143:0)
[10:54:55.057] Timer tick, asking Buildbucket for the build status
[10:54:55.147] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:55.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:144:0) after 1m0s
[10:55:55.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:144:0)
[10:55:55.218] Timer tick, asking Buildbucket for the build status
[10:55:55.269] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:55.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:145:0) after 1m0s
[10:56:55.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:145:0)
[10:56:55.292] Timer tick, asking Buildbucket for the build status
[10:56:55.349] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:55.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:146:0) after 1m0s
[10:57:55.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:146:0)
[10:57:55.353] Timer tick, asking Buildbucket for the build status
[10:57:55.437] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:55.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:147:0) after 1m0s
[10:58:55.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:147:0)
[10:58:55.544] Timer tick, asking Buildbucket for the build status
[10:58:55.716] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:55.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:148:0) after 1m0s
[10:59:55.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:148:0)
[10:59:55.797] Timer tick, asking Buildbucket for the build status
[10:59:56.029] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:56.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:149:0) after 1m0s
[11:00:56.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:149:0)
[11:00:56.088] Timer tick, asking Buildbucket for the build status
[11:00:56.162] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:56.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:150:0) after 1m0s
[11:01:56.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:150:0)
[11:01:56.191] Timer tick, asking Buildbucket for the build status
[11:01:56.265] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:56.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:151:0) after 1m0s
[11:02:56.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:151:0)
[11:02:56.249] Timer tick, asking Buildbucket for the build status
[11:02:56.323] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:56.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:152:0) after 1m0s
[11:03:56.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:152:0)
[11:03:56.348] Timer tick, asking Buildbucket for the build status
[11:03:56.462] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:56.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:153:0) after 1m0s
[11:04:56.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:153:0)
[11:04:56.452] Timer tick, asking Buildbucket for the build status
[11:04:56.525] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:56.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:154:0) after 1m0s
[11:05:56.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:154:0)
[11:05:56.585] Timer tick, asking Buildbucket for the build status
[11:05:56.653] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:56.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:155:0) after 1m0s
[11:06:56.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:155:0)
[11:06:56.691] Timer tick, asking Buildbucket for the build status
[11:06:56.760] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:56.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:156:0) after 1m0s
[11:07:56.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:156:0)
[11:07:56.787] Timer tick, asking Buildbucket for the build status
[11:07:56.851] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:56.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:157:0) after 1m0s
[11:08:56.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:157:0)
[11:08:56.902] Timer tick, asking Buildbucket for the build status
[11:08:57.018] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:57.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:158:0) after 1m0s
[11:09:57.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:158:0)
[11:09:57.051] Timer tick, asking Buildbucket for the build status
[11:09:57.243] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:57.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:159:0) after 1m0s
[11:10:57.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:159:0)
[11:10:57.302] Timer tick, asking Buildbucket for the build status
[11:10:57.375] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:57.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:160:0) after 1m0s
[11:11:57.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:160:0)
[11:11:57.466] Timer tick, asking Buildbucket for the build status
[11:11:57.523] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:57.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:161:0) after 1m0s
[11:12:57.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:161:0)
[11:12:57.575] Timer tick, asking Buildbucket for the build status
[11:12:57.626] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:57.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:162:0) after 1m0s
[11:13:57.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:162:0)
[11:13:57.635] Timer tick, asking Buildbucket for the build status
[11:13:58.929] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:58.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:163:0) after 1m0s
[11:14:58.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:163:0)
[11:14:58.930] Timer tick, asking Buildbucket for the build status
[11:14:58.994] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:58.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:164:0) after 1m0s
[11:15:58.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:164:0)
[11:15:58.996] Timer tick, asking Buildbucket for the build status
[11:15:59.063] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:59.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:165:0) after 1m0s
[11:16:59.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:165:0)
[11:16:59.134] Timer tick, asking Buildbucket for the build status
[11:16:59.207] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:59.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:166:0) after 1m0s
[11:17:59.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:166:0)
[11:17:59.241] Timer tick, asking Buildbucket for the build status
[11:17:59.299] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:59.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:167:0) after 1m0s
[11:18:59.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:167:0)
[11:18:59.372] Timer tick, asking Buildbucket for the build status
[11:18:59.473] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:59.473] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:168:0) after 1m0s
[11:19:59.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:168:0)
[11:19:59.521] Timer tick, asking Buildbucket for the build status
[11:20:00.159] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:00.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:169:0) after 1m0s
[11:21:00.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:169:0)
[11:21:00.264] Timer tick, asking Buildbucket for the build status
[11:21:00.435] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:00.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:170:0) after 1m0s
[11:22:01.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:170:0)
[11:22:01.363] Timer tick, asking Buildbucket for the build status
[11:22:01.425] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:01.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:171:0) after 1m0s
[11:23:01.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:171:0)
[11:23:01.615] Timer tick, asking Buildbucket for the build status
[11:23:01.676] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:01.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:172:0) after 1m0s
[11:24:01.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:172:0)
[11:24:01.953] Timer tick, asking Buildbucket for the build status
[11:24:03.005] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:03.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:173:0) after 1m0s
[11:25:03.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:173:0)
[11:25:03.133] Timer tick, asking Buildbucket for the build status
[11:25:03.336] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:03.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:174:0) after 1m0s
[11:26:03.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:174:0)
[11:26:03.364] Timer tick, asking Buildbucket for the build status
[11:26:03.429] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:03.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:175:0) after 1m0s
[11:27:03.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:175:0)
[11:27:03.534] Timer tick, asking Buildbucket for the build status
[11:27:03.620] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:03.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:176:0) after 1m0s
[11:28:03.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:176:0)
[11:28:03.647] Timer tick, asking Buildbucket for the build status
[11:28:03.709] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:03.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:177:0) after 1m0s
[11:29:03.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:177:0)
[11:29:03.726] Timer tick, asking Buildbucket for the build status
[11:29:03.817] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:03.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:178:0) after 1m0s
[11:30:03.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:178:0)
[11:30:03.942] Timer tick, asking Buildbucket for the build status
[11:30:04.110] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:04.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:179:0) after 1m0s
[11:31:04.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:179:0)
[11:31:04.110] Timer tick, asking Buildbucket for the build status
[11:31:04.317] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:04.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:180:0) after 1m0s
[11:32:04.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:180:0)
[11:32:04.351] Timer tick, asking Buildbucket for the build status
[11:32:04.519] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:04.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:181:0) after 1m0s
[11:33:04.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:181:0)
[11:33:04.566] Timer tick, asking Buildbucket for the build status
[11:33:04.772] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:04.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:182:0) after 1m0s
[11:34:04.826] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:182:0)
[11:34:04.826] Timer tick, asking Buildbucket for the build status
[11:34:04.956] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:04.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:183:0) after 1m0s
[11:35:05.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:183:0)
[11:35:05.033] Timer tick, asking Buildbucket for the build status
[11:35:05.632] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:05.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:184:0) after 1m0s
[11:36:05.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:184:0)
[11:36:05.681] Timer tick, asking Buildbucket for the build status
[11:36:05.744] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:05.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:185:0) after 1m0s
[11:37:05.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:185:0)
[11:37:05.916] Timer tick, asking Buildbucket for the build status
[11:37:06.002] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:06.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:186:0) after 1m0s
[11:38:06.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:186:0)
[11:38:06.155] Timer tick, asking Buildbucket for the build status
[11:38:06.213] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:06.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:187:0) after 1m0s
[11:39:06.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:187:0)
[11:39:06.601] Timer tick, asking Buildbucket for the build status
[11:39:06.702] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:06.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:188:0) after 1m0s
[11:40:06.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:188:0)
[11:40:06.847] Timer tick, asking Buildbucket for the build status
[11:40:06.906] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:06.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:189:0) after 1m0s
[11:41:07.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:189:0)
[11:41:07.301] Timer tick, asking Buildbucket for the build status
[11:41:07.375] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:07.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:190:0) after 1m0s
[11:42:07.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:190:0)
[11:42:07.454] Timer tick, asking Buildbucket for the build status
[11:42:07.523] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:07.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:191:0) after 1m0s
[11:43:07.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:191:0)
[11:43:07.609] Timer tick, asking Buildbucket for the build status
[11:43:07.725] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:07.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:192:0) after 1m0s
[11:44:07.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:192:0)
[11:44:07.819] Timer tick, asking Buildbucket for the build status
[11:44:07.916] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:07.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:193:0) after 1m0s
[11:45:07.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:193:0)
[11:45:07.948] Timer tick, asking Buildbucket for the build status
[11:45:08.012] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:08.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:194:0) after 1m0s
[11:46:08.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:194:0)
[11:46:08.131] Timer tick, asking Buildbucket for the build status
[11:46:08.276] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:08.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:195:0) after 1m0s
[11:47:08.399] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:195:0)
[11:47:08.399] Timer tick, asking Buildbucket for the build status
[11:47:09.781] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:09.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:196:0) after 1m0s
[11:48:10.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:196:0)
[11:48:10.128] Timer tick, asking Buildbucket for the build status
[11:48:10.182] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:10.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:197:0) after 1m0s
[11:49:10.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:197:0)
[11:49:10.324] Timer tick, asking Buildbucket for the build status
[11:49:10.483] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:10.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:198:0) after 1m0s
[11:50:10.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:198:0)
[11:50:10.569] Timer tick, asking Buildbucket for the build status
[11:50:10.725] Build 8862673220078517040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:10.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028103282174563168:199:0) after 1m0s
[11:50:26.120] Received PubSub notification, asking Buildbucket for the build status
[11:50:26.195] Build 8862673220078517040: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:50:26.195] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1606305025044731",
    "created_by": "project:infra",
    "created_ts": "1606293197517496",
    "id": "8862673220078517040",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"89.0.4336.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f32768fd-9b95-4e4e-9ef2-9b25d201f23e\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"89.0.4336.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2\", \"git\", \"goma_v2\", \"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-oe0a\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1606293201643981",
    "status": "COMPLETED",
    "status_changed_ts": "1606305025465675",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9028103282174563168",
      "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/8862673220078517040/+/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:50175a9c62521710",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1606305025478526",
    "url": "https://ci.chromium.org/b/8862673220078517040",
    "utcnow_ts": "1606305026185541"
  }
}
[11:50:26.195] Invocation finished in 3h17m10.05967247s with status SUCCEEDED