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.4147.10"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[09:38:31.262] New invocation is queued and will start shortly
[09:38:31.262] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[09:38:32.471] Starting the invocation (attempt 1)
[09:38:32.517] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:38:32.517] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:38:32.518] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9045040809603556704",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"84.0.4147.10\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"9aad29d0-e0da-4a6f-bc8d-6a708e348fa3\",\"title\":\"publish_tarball/0\"}]},\"version\":\"84.0.4147.10\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9045040809603556704",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[09:38:33.296] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1590140312627513",
    "id": "8879610747505480368",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4147.10\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9aad29d0-e0da-4a6f-bc8d-6a708e348fa3\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4147.10\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1590140312953400",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9045040809603556704",
      "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/8879610747505480368/+/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": "1590140312953596",
    "url": "https://ci.chromium.org/b/8879610747505480368",
    "utcnow_ts": "1590140313255200"
  }
}
[09:38:33.296] Task URL: https://ci.chromium.org/b/8879610747505480368
[09:38:33.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:2:0) after 1m0s
[09:39:33.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:2:0)
[09:39:33.324] Timer tick, asking Buildbucket for the build status
[09:39:33.490] Build 8879610747505480368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:39:33.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:3:0) after 1m0s
[09:40:33.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:3:0)
[09:40:33.514] Timer tick, asking Buildbucket for the build status
[09:40:35.212] Build 8879610747505480368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:40:35.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:4:0) after 1m0s
[09:41:35.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:4:0)
[09:41:35.238] Timer tick, asking Buildbucket for the build status
[09:41:35.391] Build 8879610747505480368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:41:35.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:5:0) after 1m0s
[09:42:35.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:5:0)
[09:42:35.418] Timer tick, asking Buildbucket for the build status
[09:42:35.711] Build 8879610747505480368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:42:35.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:6:0) after 1m0s
[09:43:35.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:6:0)
[09:43:35.782] Timer tick, asking Buildbucket for the build status
[09:43:35.919] Build 8879610747505480368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:43:35.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:7:0) after 1m0s
[09:44:35.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:7:0)
[09:44:35.967] Timer tick, asking Buildbucket for the build status
[09:44:36.316] Build 8879610747505480368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:44:36.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:8:0) after 1m0s
[09:45:36.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:8:0)
[09:45:36.377] Timer tick, asking Buildbucket for the build status
[09:45:36.899] Build 8879610747505480368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:45:36.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:9:0) after 1m0s
[09:46:36.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:9:0)
[09:46:36.935] Timer tick, asking Buildbucket for the build status
[09:46:37.147] Build 8879610747505480368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:46:37.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:10:0) after 1m0s
[09:47:26.732] Received PubSub notification, asking Buildbucket for the build status
[09:47:26.847] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:37.171] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:10:0)
[09:47:37.171] Timer tick, asking Buildbucket for the build status
[09:47:37.997] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:37.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:12:0) after 1m0s
[09:48:38.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:12:0)
[09:48:38.024] Timer tick, asking Buildbucket for the build status
[09:48:38.204] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:38.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:13:0) after 1m0s
[09:49:38.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:13:0)
[09:49:38.224] Timer tick, asking Buildbucket for the build status
[09:49:38.324] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:38.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:14:0) after 1m0s
[09:50:38.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:14:0)
[09:50:38.348] Timer tick, asking Buildbucket for the build status
[09:50:38.678] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:38.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:15:0) after 1m0s
[09:51:38.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:15:0)
[09:51:38.725] Timer tick, asking Buildbucket for the build status
[09:51:38.904] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:38.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:16:0) after 1m0s
[09:52:38.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:16:0)
[09:52:38.943] Timer tick, asking Buildbucket for the build status
[09:52:39.072] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:39.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:17:0) after 1m0s
[09:53:39.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:17:0)
[09:53:39.093] Timer tick, asking Buildbucket for the build status
[09:53:39.206] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:39.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:18:0) after 1m0s
[09:54:39.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:18:0)
[09:54:39.251] Timer tick, asking Buildbucket for the build status
[09:54:39.410] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:39.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:19:0) after 1m0s
[09:55:39.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:19:0)
[09:55:39.432] Timer tick, asking Buildbucket for the build status
[09:55:40.468] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:40.468] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:20:0) after 1m0s
[09:56:40.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:20:0)
[09:56:40.486] Timer tick, asking Buildbucket for the build status
[09:56:40.692] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:40.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:21:0) after 1m0s
[09:57:40.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:21:0)
[09:57:40.720] Timer tick, asking Buildbucket for the build status
[09:57:40.948] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:40.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:22:0) after 1m0s
[09:58:40.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:22:0)
[09:58:40.967] Timer tick, asking Buildbucket for the build status
[09:58:41.599] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:41.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:23:0) after 1m0s
[09:59:41.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:23:0)
[09:59:41.651] Timer tick, asking Buildbucket for the build status
[09:59:41.823] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:41.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:24:0) after 1m0s
[10:00:41.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:24:0)
[10:00:41.845] Timer tick, asking Buildbucket for the build status
[10:00:45.660] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:45.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:25:0) after 1m0s
[10:01:45.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:25:0)
[10:01:45.686] Timer tick, asking Buildbucket for the build status
[10:01:46.118] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:46.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:26:0) after 1m0s
[10:02:46.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:26:0)
[10:02:46.217] Timer tick, asking Buildbucket for the build status
[10:02:46.364] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:46.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:27:0) after 1m0s
[10:03:46.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:27:0)
[10:03:46.572] Timer tick, asking Buildbucket for the build status
[10:03:46.780] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:46.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:28:0) after 1m0s
[10:04:46.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:28:0)
[10:04:46.860] Timer tick, asking Buildbucket for the build status
[10:04:47.019] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:47.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:29:0) after 1m0s
[10:05:47.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:29:0)
[10:05:47.044] Timer tick, asking Buildbucket for the build status
[10:05:51.714] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:51.714] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:30:0) after 1m0s
[10:06:51.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:30:0)
[10:06:51.822] Timer tick, asking Buildbucket for the build status
[10:06:51.965] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:51.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:31:0) after 1m0s
[10:07:51.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:31:0)
[10:07:51.991] Timer tick, asking Buildbucket for the build status
[10:07:52.118] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:52.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:32:0) after 1m0s
[10:08:52.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:32:0)
[10:08:52.194] Timer tick, asking Buildbucket for the build status
[10:08:52.351] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:52.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:33:0) after 1m0s
[10:09:52.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:33:0)
[10:09:52.384] Timer tick, asking Buildbucket for the build status
[10:09:52.658] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:52.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:34:0) after 1m0s
[10:10:52.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:34:0)
[10:10:52.678] Timer tick, asking Buildbucket for the build status
[10:10:52.846] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:52.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:35:0) after 1m0s
[10:11:52.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:35:0)
[10:11:52.936] Timer tick, asking Buildbucket for the build status
[10:11:53.270] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:53.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:36:0) after 1m0s
[10:12:53.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:36:0)
[10:12:53.294] Timer tick, asking Buildbucket for the build status
[10:12:53.391] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:53.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:37:0) after 1m0s
[10:13:53.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:37:0)
[10:13:53.460] Timer tick, asking Buildbucket for the build status
[10:13:53.586] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:53.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:38:0) after 1m0s
[10:14:53.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:38:0)
[10:14:53.617] Timer tick, asking Buildbucket for the build status
[10:14:53.735] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:53.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:39:0) after 1m0s
[10:15:53.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:39:0)
[10:15:53.806] Timer tick, asking Buildbucket for the build status
[10:15:53.944] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:53.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:40:0) after 1m0s
[10:16:54.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:40:0)
[10:16:54.005] Timer tick, asking Buildbucket for the build status
[10:16:54.219] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:54.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:41:0) after 1m0s
[10:17:54.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:41:0)
[10:17:54.344] Timer tick, asking Buildbucket for the build status
[10:17:54.461] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:54.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:42:0) after 1m0s
[10:18:54.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:42:0)
[10:18:54.612] Timer tick, asking Buildbucket for the build status
[10:18:54.732] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:54.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:43:0) after 1m0s
[10:19:54.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:43:0)
[10:19:54.836] Timer tick, asking Buildbucket for the build status
[10:19:54.987] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:54.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:44:0) after 1m0s
[10:20:55.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:44:0)
[10:20:55.075] Timer tick, asking Buildbucket for the build status
[10:20:55.293] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:55.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:45:0) after 1m0s
[10:21:55.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:45:0)
[10:21:55.477] Timer tick, asking Buildbucket for the build status
[10:21:55.597] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:55.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:46:0) after 1m0s
[10:22:55.772] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:46:0)
[10:22:55.772] Timer tick, asking Buildbucket for the build status
[10:22:56.206] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:56.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:47:0) after 1m0s
[10:23:56.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:47:0)
[10:23:56.282] Timer tick, asking Buildbucket for the build status
[10:23:56.460] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:56.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:48:0) after 1m0s
[10:24:56.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:48:0)
[10:24:56.755] Timer tick, asking Buildbucket for the build status
[10:24:56.913] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:56.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:49:0) after 1m0s
[10:25:57.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:49:0)
[10:25:57.051] Timer tick, asking Buildbucket for the build status
[10:25:57.527] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:57.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:50:0) after 1m0s
[10:26:57.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:50:0)
[10:26:57.614] Timer tick, asking Buildbucket for the build status
[10:26:57.844] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:57.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:51:0) after 1m0s
[10:27:57.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:51:0)
[10:27:57.974] Timer tick, asking Buildbucket for the build status
[10:27:58.163] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:58.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:52:0) after 1m0s
[10:28:58.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:52:0)
[10:28:58.650] Timer tick, asking Buildbucket for the build status
[10:28:58.888] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:58.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:53:0) after 1m0s
[10:29:58.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:53:0)
[10:29:58.929] Timer tick, asking Buildbucket for the build status
[10:29:59.155] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:59.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:54:0) after 1m0s
[10:30:59.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:54:0)
[10:30:59.309] Timer tick, asking Buildbucket for the build status
[10:30:59.431] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:59.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:55:0) after 1m0s
[10:31:59.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:55:0)
[10:31:59.573] Timer tick, asking Buildbucket for the build status
[10:31:59.740] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:59.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:56:0) after 1m0s
[10:32:59.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:56:0)
[10:32:59.910] Timer tick, asking Buildbucket for the build status
[10:33:00.153] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:00.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:57:0) after 1m0s
[10:34:00.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:57:0)
[10:34:00.241] Timer tick, asking Buildbucket for the build status
[10:34:00.493] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:00.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:58:0) after 1m0s
[10:35:00.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:58:0)
[10:35:00.512] Timer tick, asking Buildbucket for the build status
[10:35:00.882] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:00.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:59:0) after 1m0s
[10:36:01.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:59:0)
[10:36:01.133] Timer tick, asking Buildbucket for the build status
[10:36:01.765] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:01.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:60:0) after 1m0s
[10:37:01.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:60:0)
[10:37:01.877] Timer tick, asking Buildbucket for the build status
[10:37:02.023] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:02.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:61:0) after 1m0s
[10:38:02.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:61:0)
[10:38:02.493] Timer tick, asking Buildbucket for the build status
[10:38:03.007] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:03.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:62:0) after 1m0s
[10:39:03.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:62:0)
[10:39:03.055] Timer tick, asking Buildbucket for the build status
[10:39:03.304] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:03.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:63:0) after 1m0s
[10:40:03.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:63:0)
[10:40:03.474] Timer tick, asking Buildbucket for the build status
[10:40:03.894] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:03.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:64:0) after 1m0s
[10:41:03.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:64:0)
[10:41:03.917] Timer tick, asking Buildbucket for the build status
[10:41:04.139] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:04.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:65:0) after 1m0s
[10:42:04.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:65:0)
[10:42:04.163] Timer tick, asking Buildbucket for the build status
[10:42:04.286] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:04.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:66:0) after 1m0s
[10:43:04.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:66:0)
[10:43:04.333] Timer tick, asking Buildbucket for the build status
[10:43:04.479] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:04.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:67:0) after 1m0s
[10:44:04.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:67:0)
[10:44:04.476] Timer tick, asking Buildbucket for the build status
[10:44:04.621] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:04.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:68:0) after 1m0s
[10:45:04.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:68:0)
[10:45:04.753] Timer tick, asking Buildbucket for the build status
[10:45:05.241] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:05.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:69:0) after 1m0s
[10:46:05.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:69:0)
[10:46:05.319] Timer tick, asking Buildbucket for the build status
[10:46:05.449] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:05.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:70:0) after 1m0s
[10:47:05.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:70:0)
[10:47:05.523] Timer tick, asking Buildbucket for the build status
[10:47:05.638] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:05.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:71:0) after 1m0s
[10:48:05.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:71:0)
[10:48:05.889] Timer tick, asking Buildbucket for the build status
[10:48:06.412] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:06.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:72:0) after 1m0s
[10:49:06.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:72:0)
[10:49:06.505] Timer tick, asking Buildbucket for the build status
[10:49:06.675] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:06.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:73:0) after 1m0s
[10:50:06.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:73:0)
[10:50:06.710] Timer tick, asking Buildbucket for the build status
[10:50:06.883] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:06.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:74:0) after 1m0s
[10:51:06.944] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:74:0)
[10:51:06.944] Timer tick, asking Buildbucket for the build status
[10:51:07.186] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:07.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:75:0) after 1m0s
[10:52:07.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:75:0)
[10:52:07.240] Timer tick, asking Buildbucket for the build status
[10:52:07.414] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:07.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:76:0) after 1m0s
[10:53:07.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:76:0)
[10:53:07.461] Timer tick, asking Buildbucket for the build status
[10:53:07.607] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:07.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:77:0) after 1m0s
[10:54:07.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:77:0)
[10:54:07.682] Timer tick, asking Buildbucket for the build status
[10:54:07.817] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:07.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:78:0) after 1m0s
[10:55:07.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:78:0)
[10:55:07.958] Timer tick, asking Buildbucket for the build status
[10:55:08.511] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:08.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:79:0) after 1m0s
[10:56:08.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:79:0)
[10:56:08.548] Timer tick, asking Buildbucket for the build status
[10:56:08.854] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:08.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:80:0) after 1m0s
[10:57:09.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:80:0)
[10:57:09.032] Timer tick, asking Buildbucket for the build status
[10:57:09.177] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:09.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:81:0) after 1m0s
[10:58:09.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:81:0)
[10:58:09.215] Timer tick, asking Buildbucket for the build status
[10:58:09.562] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:09.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:82:0) after 1m0s
[10:59:09.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:82:0)
[10:59:09.617] Timer tick, asking Buildbucket for the build status
[10:59:09.761] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:09.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:83:0) after 1m0s
[11:00:09.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:83:0)
[11:00:09.818] Timer tick, asking Buildbucket for the build status
[11:00:10.243] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:10.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:84:0) after 1m0s
[11:01:10.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:84:0)
[11:01:10.264] Timer tick, asking Buildbucket for the build status
[11:01:10.407] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:10.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:85:0) after 1m0s
[11:02:10.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:85:0)
[11:02:10.390] Timer tick, asking Buildbucket for the build status
[11:02:10.510] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:10.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:86:0) after 1m0s
[11:03:10.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:86:0)
[11:03:10.544] Timer tick, asking Buildbucket for the build status
[11:03:10.751] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:10.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:87:0) after 1m0s
[11:04:10.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:87:0)
[11:04:10.930] Timer tick, asking Buildbucket for the build status
[11:04:11.151] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:11.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:88:0) after 1m0s
[11:05:11.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:88:0)
[11:05:11.195] Timer tick, asking Buildbucket for the build status
[11:05:11.570] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:11.570] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:89:0) after 1m0s
[11:06:11.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:89:0)
[11:06:11.600] Timer tick, asking Buildbucket for the build status
[11:06:11.833] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:11.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:90:0) after 1m0s
[11:07:11.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:90:0)
[11:07:11.909] Timer tick, asking Buildbucket for the build status
[11:07:12.164] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:12.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:91:0) after 1m0s
[11:08:12.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:91:0)
[11:08:12.199] Timer tick, asking Buildbucket for the build status
[11:08:12.327] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:12.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:92:0) after 1m0s
[11:09:12.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:92:0)
[11:09:12.359] Timer tick, asking Buildbucket for the build status
[11:09:13.787] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:13.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:93:0) after 1m0s
[11:10:13.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:93:0)
[11:10:13.883] Timer tick, asking Buildbucket for the build status
[11:10:14.167] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:14.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:94:0) after 1m0s
[11:11:14.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:94:0)
[11:11:14.278] Timer tick, asking Buildbucket for the build status
[11:11:14.455] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:14.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:95:0) after 1m0s
[11:12:14.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:95:0)
[11:12:14.497] Timer tick, asking Buildbucket for the build status
[11:12:14.619] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:14.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:96:0) after 1m0s
[11:13:14.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:96:0)
[11:13:14.644] Timer tick, asking Buildbucket for the build status
[11:13:15.165] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:15.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:97:0) after 1m0s
[11:14:15.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:97:0)
[11:14:15.246] Timer tick, asking Buildbucket for the build status
[11:14:15.350] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:15.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:98:0) after 1m0s
[11:15:15.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:98:0)
[11:15:15.429] Timer tick, asking Buildbucket for the build status
[11:15:15.681] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:15.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:99:0) after 1m0s
[11:16:15.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:99:0)
[11:16:15.724] Timer tick, asking Buildbucket for the build status
[11:16:16.023] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:16.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:100:0) after 1m0s
[11:17:16.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:100:0)
[11:17:16.199] Timer tick, asking Buildbucket for the build status
[11:17:16.346] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:16.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:101:0) after 1m0s
[11:18:16.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:101:0)
[11:18:16.485] Timer tick, asking Buildbucket for the build status
[11:18:16.948] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:16.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:102:0) after 1m0s
[11:19:17.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:102:0)
[11:19:17.051] Timer tick, asking Buildbucket for the build status
[11:19:17.245] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:17.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:103:0) after 1m0s
[11:20:17.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:103:0)
[11:20:17.288] Timer tick, asking Buildbucket for the build status
[11:20:17.490] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:17.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:104:0) after 1m0s
[11:21:17.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:104:0)
[11:21:17.512] Timer tick, asking Buildbucket for the build status
[11:21:17.640] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:17.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:105:0) after 1m0s
[11:22:17.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:105:0)
[11:22:17.683] Timer tick, asking Buildbucket for the build status
[11:22:18.091] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:18.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:106:0) after 1m0s
[11:23:18.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:106:0)
[11:23:18.128] Timer tick, asking Buildbucket for the build status
[11:23:18.372] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:18.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:107:0) after 1m0s
[11:24:18.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:107:0)
[11:24:18.554] Timer tick, asking Buildbucket for the build status
[11:24:18.712] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:18.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:108:0) after 1m0s
[11:25:18.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:108:0)
[11:25:18.808] Timer tick, asking Buildbucket for the build status
[11:25:19.289] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:19.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:109:0) after 1m0s
[11:26:19.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:109:0)
[11:26:19.398] Timer tick, asking Buildbucket for the build status
[11:26:19.530] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:19.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:110:0) after 1m0s
[11:27:19.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:110:0)
[11:27:19.620] Timer tick, asking Buildbucket for the build status
[11:27:19.994] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:19.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:111:0) after 1m0s
[11:28:20.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:111:0)
[11:28:20.146] Timer tick, asking Buildbucket for the build status
[11:28:20.254] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:20.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:112:0) after 1m0s
[11:29:20.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:112:0)
[11:29:20.372] Timer tick, asking Buildbucket for the build status
[11:29:20.596] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:20.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:113:0) after 1m0s
[11:30:20.799] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:113:0)
[11:30:20.799] Timer tick, asking Buildbucket for the build status
[11:30:20.970] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:20.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:114:0) after 1m0s
[11:31:21.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:114:0)
[11:31:21.073] Timer tick, asking Buildbucket for the build status
[11:31:21.505] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:21.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:115:0) after 1m0s
[11:32:21.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:115:0)
[11:32:21.626] Timer tick, asking Buildbucket for the build status
[11:32:21.862] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:21.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:116:0) after 1m0s
[11:33:22.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:116:0)
[11:33:22.106] Timer tick, asking Buildbucket for the build status
[11:33:22.253] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:22.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:117:0) after 1m0s
[11:34:22.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:117:0)
[11:34:22.339] Timer tick, asking Buildbucket for the build status
[11:34:22.485] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:22.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:118:0) after 1m0s
[11:35:27.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:118:0)
[11:35:27.322] Timer tick, asking Buildbucket for the build status
[11:35:27.572] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:27.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:119:0) after 1m0s
[11:36:27.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:119:0)
[11:36:27.685] Timer tick, asking Buildbucket for the build status
[11:36:27.868] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:27.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:120:0) after 1m0s
[11:37:28.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:120:0)
[11:37:28.066] Timer tick, asking Buildbucket for the build status
[11:37:28.205] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:28.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:121:0) after 1m0s
[11:38:28.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:121:0)
[11:38:28.240] Timer tick, asking Buildbucket for the build status
[11:38:28.376] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:28.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:122:0) after 1m0s
[11:39:28.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:122:0)
[11:39:28.403] Timer tick, asking Buildbucket for the build status
[11:39:28.808] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:28.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:123:0) after 1m0s
[11:40:28.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:123:0)
[11:40:28.884] Timer tick, asking Buildbucket for the build status
[11:40:30.729] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:30.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:124:0) after 1m0s
[11:41:30.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:124:0)
[11:41:30.744] Timer tick, asking Buildbucket for the build status
[11:41:30.860] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:30.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:125:0) after 1m0s
[11:42:30.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:125:0)
[11:42:30.916] Timer tick, asking Buildbucket for the build status
[11:42:31.045] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:31.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:126:0) after 1m0s
[11:43:31.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:126:0)
[11:43:31.071] Timer tick, asking Buildbucket for the build status
[11:43:31.191] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:31.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:127:0) after 1m0s
[11:44:31.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:127:0)
[11:44:31.184] Timer tick, asking Buildbucket for the build status
[11:44:31.363] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:31.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:128:0) after 1m0s
[11:45:31.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:128:0)
[11:45:31.407] Timer tick, asking Buildbucket for the build status
[11:45:34.974] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:34.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:129:0) after 1m0s
[11:46:35.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:129:0)
[11:46:35.056] Timer tick, asking Buildbucket for the build status
[11:46:35.508] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:35.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:130:0) after 1m0s
[11:47:35.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:130:0)
[11:47:35.561] Timer tick, asking Buildbucket for the build status
[11:47:35.978] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:35.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:131:0) after 1m0s
[11:48:36.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:131:0)
[11:48:36.067] Timer tick, asking Buildbucket for the build status
[11:48:36.279] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:36.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:132:0) after 1m0s
[11:49:36.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:132:0)
[11:49:36.303] Timer tick, asking Buildbucket for the build status
[11:49:36.682] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:36.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:133:0) after 1m0s
[11:50:36.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:133:0)
[11:50:36.704] Timer tick, asking Buildbucket for the build status
[11:50:38.082] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:38.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:134:0) after 1m0s
[11:51:38.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:134:0)
[11:51:38.219] Timer tick, asking Buildbucket for the build status
[11:51:38.483] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:38.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:135:0) after 1m0s
[11:52:38.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:135:0)
[11:52:38.616] Timer tick, asking Buildbucket for the build status
[11:52:38.760] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:38.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:136:0) after 1m0s
[11:53:38.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:136:0)
[11:53:38.885] Timer tick, asking Buildbucket for the build status
[11:53:39.234] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:39.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:137:0) after 1m0s
[11:54:39.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:137:0)
[11:54:39.343] Timer tick, asking Buildbucket for the build status
[11:54:39.494] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:39.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:138:0) after 1m0s
[11:55:39.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:138:0)
[11:55:39.547] Timer tick, asking Buildbucket for the build status
[11:55:45.427] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:45.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:139:0) after 1m0s
[11:56:45.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:139:0)
[11:56:45.445] Timer tick, asking Buildbucket for the build status
[11:56:45.610] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:45.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:140:0) after 1m0s
[11:57:45.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:140:0)
[11:57:45.616] Timer tick, asking Buildbucket for the build status
[11:57:45.742] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:45.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:141:0) after 1m0s
[11:58:45.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:141:0)
[11:58:45.775] Timer tick, asking Buildbucket for the build status
[11:58:46.602] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:46.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:142:0) after 1m0s
[11:59:46.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:142:0)
[11:59:46.840] Timer tick, asking Buildbucket for the build status
[11:59:47.031] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:47.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:143:0) after 1m0s
[12:00:47.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:143:0)
[12:00:47.079] Timer tick, asking Buildbucket for the build status
[12:00:47.992] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:47.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:144:0) after 1m0s
[12:01:48.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:144:0)
[12:01:48.022] Timer tick, asking Buildbucket for the build status
[12:01:49.040] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:49.040] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:145:0) after 1m0s
[12:02:49.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:145:0)
[12:02:49.088] Timer tick, asking Buildbucket for the build status
[12:02:49.463] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:49.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:146:0) after 1m0s
[12:03:49.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:146:0)
[12:03:49.540] Timer tick, asking Buildbucket for the build status
[12:03:49.672] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:49.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:147:0) after 1m0s
[12:04:49.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:147:0)
[12:04:49.726] Timer tick, asking Buildbucket for the build status
[12:04:49.979] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:49.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:148:0) after 1m0s
[12:05:50.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:148:0)
[12:05:50.031] Timer tick, asking Buildbucket for the build status
[12:05:50.200] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:50.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:149:0) after 1m0s
[12:06:50.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:149:0)
[12:06:50.199] Timer tick, asking Buildbucket for the build status
[12:06:50.351] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:50.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:150:0) after 1m0s
[12:07:50.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:150:0)
[12:07:50.379] Timer tick, asking Buildbucket for the build status
[12:07:50.663] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:50.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:151:0) after 1m0s
[12:08:50.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:151:0)
[12:08:50.853] Timer tick, asking Buildbucket for the build status
[12:08:50.986] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:50.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:152:0) after 1m0s
[12:09:51.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:152:0)
[12:09:51.165] Timer tick, asking Buildbucket for the build status
[12:09:51.335] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:51.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:153:0) after 1m0s
[12:10:51.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:153:0)
[12:10:51.487] Timer tick, asking Buildbucket for the build status
[12:10:51.907] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:51.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:154:0) after 1m0s
[12:11:51.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:154:0)
[12:11:51.970] Timer tick, asking Buildbucket for the build status
[12:11:52.107] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:52.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:155:0) after 1m0s
[12:12:52.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:155:0)
[12:12:52.144] Timer tick, asking Buildbucket for the build status
[12:12:52.362] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:52.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:156:0) after 1m0s
[12:13:52.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:156:0)
[12:13:52.387] Timer tick, asking Buildbucket for the build status
[12:13:52.554] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:52.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:157:0) after 1m0s
[12:14:52.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:157:0)
[12:14:52.578] Timer tick, asking Buildbucket for the build status
[12:14:52.760] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:52.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:158:0) after 1m0s
[12:15:52.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:158:0)
[12:15:52.779] Timer tick, asking Buildbucket for the build status
[12:15:52.927] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:52.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:159:0) after 1m0s
[12:16:52.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:159:0)
[12:16:52.938] Timer tick, asking Buildbucket for the build status
[12:16:53.229] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:53.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:160:0) after 1m0s
[12:17:53.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:160:0)
[12:17:53.236] Timer tick, asking Buildbucket for the build status
[12:17:53.375] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:53.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:161:0) after 1m0s
[12:18:53.491] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:161:0)
[12:18:53.491] Timer tick, asking Buildbucket for the build status
[12:18:53.655] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:53.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:162:0) after 1m0s
[12:19:53.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:162:0)
[12:19:53.869] Timer tick, asking Buildbucket for the build status
[12:19:54.363] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:54.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:163:0) after 1m0s
[12:20:54.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:163:0)
[12:20:54.502] Timer tick, asking Buildbucket for the build status
[12:20:54.658] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:54.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:164:0) after 1m0s
[12:21:54.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:164:0)
[12:21:54.700] Timer tick, asking Buildbucket for the build status
[12:21:54.839] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:54.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:165:0) after 1m0s
[12:22:54.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:165:0)
[12:22:54.863] Timer tick, asking Buildbucket for the build status
[12:22:55.099] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:55.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:166:0) after 1m0s
[12:23:55.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:166:0)
[12:23:55.192] Timer tick, asking Buildbucket for the build status
[12:23:55.537] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:55.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:167:0) after 1m0s
[12:24:55.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:167:0)
[12:24:55.634] Timer tick, asking Buildbucket for the build status
[12:24:55.787] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:55.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:168:0) after 1m0s
[12:25:55.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:168:0)
[12:25:55.894] Timer tick, asking Buildbucket for the build status
[12:25:56.172] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:56.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:169:0) after 1m0s
[12:26:56.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:169:0)
[12:26:56.262] Timer tick, asking Buildbucket for the build status
[12:26:56.433] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:56.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:170:0) after 1m0s
[12:27:56.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:170:0)
[12:27:56.562] Timer tick, asking Buildbucket for the build status
[12:27:56.929] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:56.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:171:0) after 1m0s
[12:28:56.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:171:0)
[12:28:56.979] Timer tick, asking Buildbucket for the build status
[12:28:57.136] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:57.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:172:0) after 1m0s
[12:29:57.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:172:0)
[12:29:57.174] Timer tick, asking Buildbucket for the build status
[12:29:57.752] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:57.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:173:0) after 1m0s
[12:30:57.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:173:0)
[12:30:57.809] Timer tick, asking Buildbucket for the build status
[12:30:58.202] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:58.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:174:0) after 1m0s
[12:31:58.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:174:0)
[12:31:58.278] Timer tick, asking Buildbucket for the build status
[12:31:58.475] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:58.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:175:0) after 1m0s
[12:32:58.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:175:0)
[12:32:58.465] Timer tick, asking Buildbucket for the build status
[12:32:58.590] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:58.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:176:0) after 1m0s
[12:33:58.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:176:0)
[12:33:58.622] Timer tick, asking Buildbucket for the build status
[12:33:58.748] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:58.748] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:177:0) after 1m0s
[12:34:58.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:177:0)
[12:34:58.795] Timer tick, asking Buildbucket for the build status
[12:34:58.947] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:58.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:178:0) after 1m0s
[12:35:59.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:178:0)
[12:35:59.032] Timer tick, asking Buildbucket for the build status
[12:35:59.297] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:59.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:179:0) after 1m0s
[12:36:59.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:179:0)
[12:36:59.448] Timer tick, asking Buildbucket for the build status
[12:36:59.632] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:59.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:180:0) after 1m0s
[12:37:59.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:180:0)
[12:37:59.658] Timer tick, asking Buildbucket for the build status
[12:37:59.780] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:59.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:181:0) after 1m0s
[12:38:59.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:181:0)
[12:38:59.865] Timer tick, asking Buildbucket for the build status
[12:38:59.981] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:59.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:182:0) after 1m0s
[12:40:00.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:182:0)
[12:40:00.008] Timer tick, asking Buildbucket for the build status
[12:40:00.256] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:00.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:183:0) after 1m0s
[12:41:00.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:183:0)
[12:41:00.950] Timer tick, asking Buildbucket for the build status
[12:41:02.179] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:02.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:184:0) after 1m0s
[12:42:02.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:184:0)
[12:42:02.228] Timer tick, asking Buildbucket for the build status
[12:42:02.363] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:02.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:185:0) after 1m0s
[12:43:02.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:185:0)
[12:43:02.388] Timer tick, asking Buildbucket for the build status
[12:43:02.847] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:02.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:186:0) after 1m0s
[12:44:02.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:186:0)
[12:44:02.894] Timer tick, asking Buildbucket for the build status
[12:44:03.037] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:03.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:187:0) after 1m0s
[12:45:03.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:187:0)
[12:45:03.065] Timer tick, asking Buildbucket for the build status
[12:45:03.464] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:03.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:188:0) after 1m0s
[12:46:03.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:188:0)
[12:46:03.497] Timer tick, asking Buildbucket for the build status
[12:46:03.731] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:03.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:189:0) after 1m0s
[12:47:03.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:189:0)
[12:47:03.761] Timer tick, asking Buildbucket for the build status
[12:47:03.929] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:03.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:190:0) after 1m0s
[12:48:03.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:190:0)
[12:48:03.973] Timer tick, asking Buildbucket for the build status
[12:48:04.181] Build 8879610747505480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:04.181] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045040809603556704:191:0) after 1m0s
[12:49:02.895] Received PubSub notification, asking Buildbucket for the build status
[12:49:03.041] Build 8879610747505480368: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:49:03.041] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1590151741736531",
    "created_by": "project:infra",
    "created_ts": "1590140312627513",
    "id": "8879610747505480368",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4147.10\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9aad29d0-e0da-4a6f-bc8d-6a708e348fa3\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4147.10\"}}",
    "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.4147.10\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9aad29d0-e0da-4a6f-bc8d-6a708e348fa3\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-v056\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"84.0.4147.10\"}, \"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-v056\"], \"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\": [\"5100-d2625c1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1590140844893099",
    "status": "COMPLETED",
    "status_changed_ts": "1590151742369094",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9045040809603556704",
      "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/8879610747505480368/+/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:4c54912912814010",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1590151742388582",
    "url": "https://ci.chromium.org/b/8879610747505480368",
    "utcnow_ts": "1590151743023783"
  }
}
[12:49:03.041] Invocation finished in 3h10m31.799409059s with status SUCCEEDED