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

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

{
  "version": "85.0.4153.0"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[08:43:18.905] New invocation is queued and will start shortly
[08:43:18.905] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:43:19.953] Starting the invocation (attempt 1)
[08:43:19.990] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:43:19.990] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:43:19.990] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9044953685890001216",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4153.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"c9443356-1e69-4c52-a974-bc10995f23bc\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4153.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:9044953685890001216",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[08:43:20.718] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1590223400188823",
    "id": "8879523623882249376",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4153.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"c9443356-1e69-4c52-a974-bc10995f23bc\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4153.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1590223400518518",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9044953685890001216",
      "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/8879523623882249376/+/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": "1590223400518638",
    "url": "https://ci.chromium.org/b/8879523623882249376",
    "utcnow_ts": "1590223400707004"
  }
}
[08:43:20.718] Task URL: https://ci.chromium.org/b/8879523623882249376
[08:43:20.718] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:2:0) after 1m0s
[08:43:54.530] Received PubSub notification, asking Buildbucket for the build status
[08:43:54.712] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:20.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:2:0)
[08:44:20.814] Timer tick, asking Buildbucket for the build status
[08:44:21.165] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:21.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:4:0) after 1m0s
[08:45:21.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:4:0)
[08:45:21.184] Timer tick, asking Buildbucket for the build status
[08:45:21.330] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:21.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:5:0) after 1m0s
[08:46:21.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:5:0)
[08:46:21.371] Timer tick, asking Buildbucket for the build status
[08:46:21.693] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:21.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:6:0) after 1m0s
[08:47:21.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:6:0)
[08:47:21.723] Timer tick, asking Buildbucket for the build status
[08:47:21.842] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:21.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:7:0) after 1m0s
[08:48:21.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:7:0)
[08:48:21.864] Timer tick, asking Buildbucket for the build status
[08:48:22.016] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:22.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:8:0) after 1m0s
[08:49:22.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:8:0)
[08:49:22.037] Timer tick, asking Buildbucket for the build status
[08:49:22.913] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:22.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:9:0) after 1m0s
[08:50:22.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:9:0)
[08:50:22.991] Timer tick, asking Buildbucket for the build status
[08:50:25.534] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:25.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:10:0) after 1m0s
[08:51:25.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:10:0)
[08:51:25.590] Timer tick, asking Buildbucket for the build status
[08:51:26.055] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:26.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:11:0) after 1m0s
[08:52:26.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:11:0)
[08:52:26.075] Timer tick, asking Buildbucket for the build status
[08:52:26.227] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:26.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:12:0) after 1m0s
[08:53:26.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:12:0)
[08:53:26.252] Timer tick, asking Buildbucket for the build status
[08:53:26.428] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:26.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:13:0) after 1m0s
[08:54:26.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:13:0)
[08:54:26.403] Timer tick, asking Buildbucket for the build status
[08:54:26.494] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:26.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:14:0) after 1m0s
[08:55:26.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:14:0)
[08:55:26.565] Timer tick, asking Buildbucket for the build status
[08:55:27.464] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:27.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:15:0) after 1m0s
[08:56:27.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:15:0)
[08:56:27.480] Timer tick, asking Buildbucket for the build status
[08:56:27.586] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:27.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:16:0) after 1m0s
[08:57:27.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:16:0)
[08:57:27.605] Timer tick, asking Buildbucket for the build status
[08:57:27.787] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:27.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:17:0) after 1m0s
[08:58:27.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:17:0)
[08:58:27.810] Timer tick, asking Buildbucket for the build status
[08:58:28.532] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:28.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:18:0) after 1m0s
[08:59:28.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:18:0)
[08:59:28.553] Timer tick, asking Buildbucket for the build status
[08:59:28.776] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:28.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:19:0) after 1m0s
[09:00:28.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:19:0)
[09:00:28.803] Timer tick, asking Buildbucket for the build status
[09:00:29.196] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:29.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:20:0) after 1m0s
[09:01:29.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:20:0)
[09:01:29.268] Timer tick, asking Buildbucket for the build status
[09:01:30.901] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:30.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:21:0) after 1m0s
[09:02:30.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:21:0)
[09:02:30.929] Timer tick, asking Buildbucket for the build status
[09:02:31.131] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:31.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:22:0) after 1m0s
[09:03:31.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:22:0)
[09:03:31.167] Timer tick, asking Buildbucket for the build status
[09:03:31.327] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:31.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:23:0) after 1m0s
[09:04:31.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:23:0)
[09:04:31.348] Timer tick, asking Buildbucket for the build status
[09:04:31.697] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:31.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:24:0) after 1m0s
[09:05:31.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:24:0)
[09:05:31.820] Timer tick, asking Buildbucket for the build status
[09:05:32.207] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:32.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:25:0) after 1m0s
[09:06:32.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:25:0)
[09:06:32.267] Timer tick, asking Buildbucket for the build status
[09:06:32.536] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:32.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:26:0) after 1m0s
[09:07:32.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:26:0)
[09:07:32.632] Timer tick, asking Buildbucket for the build status
[09:07:32.921] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:32.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:27:0) after 1m0s
[09:08:32.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:27:0)
[09:08:32.899] Timer tick, asking Buildbucket for the build status
[09:08:33.079] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:33.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:28:0) after 1m0s
[09:09:33.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:28:0)
[09:09:33.127] Timer tick, asking Buildbucket for the build status
[09:09:33.328] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:33.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:29:0) after 1m0s
[09:10:33.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:29:0)
[09:10:33.350] Timer tick, asking Buildbucket for the build status
[09:10:33.789] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:33.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:30:0) after 1m0s
[09:11:33.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:30:0)
[09:11:33.840] Timer tick, asking Buildbucket for the build status
[09:11:35.810] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:35.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:31:0) after 1m0s
[09:12:35.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:31:0)
[09:12:35.869] Timer tick, asking Buildbucket for the build status
[09:12:36.017] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:36.017] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:32:0) after 1m0s
[09:13:36.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:32:0)
[09:13:36.062] Timer tick, asking Buildbucket for the build status
[09:13:36.275] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:36.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:33:0) after 1m0s
[09:14:36.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:33:0)
[09:14:36.337] Timer tick, asking Buildbucket for the build status
[09:14:36.457] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:36.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:34:0) after 1m0s
[09:15:36.772] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:34:0)
[09:15:36.772] Timer tick, asking Buildbucket for the build status
[09:15:36.995] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:36.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:35:0) after 1m0s
[09:16:37.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:35:0)
[09:16:37.058] Timer tick, asking Buildbucket for the build status
[09:16:37.187] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:37.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:36:0) after 1m0s
[09:17:37.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:36:0)
[09:17:37.503] Timer tick, asking Buildbucket for the build status
[09:17:37.735] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:37.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:37:0) after 1m0s
[09:18:37.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:37:0)
[09:18:37.807] Timer tick, asking Buildbucket for the build status
[09:18:37.955] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:37.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:38:0) after 1m0s
[09:19:38.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:38:0)
[09:19:38.038] Timer tick, asking Buildbucket for the build status
[09:19:38.367] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:38.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:39:0) after 1m0s
[09:20:38.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:39:0)
[09:20:38.580] Timer tick, asking Buildbucket for the build status
[09:20:39.106] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:39.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:40:0) after 1m0s
[09:21:39.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:40:0)
[09:21:39.219] Timer tick, asking Buildbucket for the build status
[09:21:39.628] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:39.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:41:0) after 1m0s
[09:22:39.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:41:0)
[09:22:39.746] Timer tick, asking Buildbucket for the build status
[09:22:39.909] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:39.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:42:0) after 1m0s
[09:23:40.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:42:0)
[09:23:40.076] Timer tick, asking Buildbucket for the build status
[09:23:40.450] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:40.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:43:0) after 1m0s
[09:24:40.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:43:0)
[09:24:40.530] Timer tick, asking Buildbucket for the build status
[09:24:40.896] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:40.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:44:0) after 1m0s
[09:25:40.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:44:0)
[09:25:40.927] Timer tick, asking Buildbucket for the build status
[09:25:41.068] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:41.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:45:0) after 1m0s
[09:26:41.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:45:0)
[09:26:41.223] Timer tick, asking Buildbucket for the build status
[09:26:41.375] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:41.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:46:0) after 1m0s
[09:27:41.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:46:0)
[09:27:41.561] Timer tick, asking Buildbucket for the build status
[09:27:41.723] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:41.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:47:0) after 1m0s
[09:28:41.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:47:0)
[09:28:41.899] Timer tick, asking Buildbucket for the build status
[09:28:42.319] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:42.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:48:0) after 1m0s
[09:29:42.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:48:0)
[09:29:42.393] Timer tick, asking Buildbucket for the build status
[09:29:42.639] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:42.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:49:0) after 1m0s
[09:30:42.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:49:0)
[09:30:42.666] Timer tick, asking Buildbucket for the build status
[09:30:43.364] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:43.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:50:0) after 1m0s
[09:31:43.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:50:0)
[09:31:43.375] Timer tick, asking Buildbucket for the build status
[09:31:43.640] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:43.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:51:0) after 1m0s
[09:32:43.663] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:51:0)
[09:32:43.663] Timer tick, asking Buildbucket for the build status
[09:32:43.832] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:43.832] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:52:0) after 1m0s
[09:33:43.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:52:0)
[09:33:43.832] Timer tick, asking Buildbucket for the build status
[09:33:44.320] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:44.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:53:0) after 1m0s
[09:34:44.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:53:0)
[09:34:44.442] Timer tick, asking Buildbucket for the build status
[09:34:44.597] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:44.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:54:0) after 1m0s
[09:35:44.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:54:0)
[09:35:44.832] Timer tick, asking Buildbucket for the build status
[09:35:45.161] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:45.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:55:0) after 1m0s
[09:36:45.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:55:0)
[09:36:45.251] Timer tick, asking Buildbucket for the build status
[09:36:45.559] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:45.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:56:0) after 1m0s
[09:37:45.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:56:0)
[09:37:45.784] Timer tick, asking Buildbucket for the build status
[09:37:45.872] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:45.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:57:0) after 1m0s
[09:38:45.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:57:0)
[09:38:45.965] Timer tick, asking Buildbucket for the build status
[09:38:46.121] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:46.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:58:0) after 1m0s
[09:39:46.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:58:0)
[09:39:46.331] Timer tick, asking Buildbucket for the build status
[09:39:46.502] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:46.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:59:0) after 1m0s
[09:40:46.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:59:0)
[09:40:46.653] Timer tick, asking Buildbucket for the build status
[09:40:46.789] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:46.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:60:0) after 1m0s
[09:41:46.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:60:0)
[09:41:46.885] Timer tick, asking Buildbucket for the build status
[09:41:47.020] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:47.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:61:0) after 1m0s
[09:42:47.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:61:0)
[09:42:47.194] Timer tick, asking Buildbucket for the build status
[09:42:47.367] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:47.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:62:0) after 1m0s
[09:43:47.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:62:0)
[09:43:47.499] Timer tick, asking Buildbucket for the build status
[09:43:47.788] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:47.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:63:0) after 1m0s
[09:44:47.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:63:0)
[09:44:47.859] Timer tick, asking Buildbucket for the build status
[09:44:48.074] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:48.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:64:0) after 1m0s
[09:45:48.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:64:0)
[09:45:48.138] Timer tick, asking Buildbucket for the build status
[09:45:48.272] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:48.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:65:0) after 1m0s
[09:46:48.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:65:0)
[09:46:48.352] Timer tick, asking Buildbucket for the build status
[09:46:48.630] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:48.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:66:0) after 1m0s
[09:47:48.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:66:0)
[09:47:48.827] Timer tick, asking Buildbucket for the build status
[09:47:48.999] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:48.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:67:0) after 1m0s
[09:48:49.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:67:0)
[09:48:49.200] Timer tick, asking Buildbucket for the build status
[09:48:50.458] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:50.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:68:0) after 1m0s
[09:49:50.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:68:0)
[09:49:50.556] Timer tick, asking Buildbucket for the build status
[09:49:50.748] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:50.748] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:69:0) after 1m0s
[09:50:50.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:69:0)
[09:50:50.875] Timer tick, asking Buildbucket for the build status
[09:50:51.042] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:51.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:70:0) after 1m0s
[09:51:51.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:70:0)
[09:51:51.238] Timer tick, asking Buildbucket for the build status
[09:51:51.501] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:51.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:71:0) after 1m0s
[09:52:51.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:71:0)
[09:52:51.558] Timer tick, asking Buildbucket for the build status
[09:52:51.730] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:51.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:72:0) after 1m0s
[09:53:51.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:72:0)
[09:53:51.820] Timer tick, asking Buildbucket for the build status
[09:53:52.201] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:52.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:73:0) after 1m0s
[09:54:52.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:73:0)
[09:54:52.365] Timer tick, asking Buildbucket for the build status
[09:54:52.511] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:52.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:74:0) after 1m0s
[09:55:52.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:74:0)
[09:55:52.493] Timer tick, asking Buildbucket for the build status
[09:55:52.820] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:52.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:75:0) after 1m0s
[09:56:52.844] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:75:0)
[09:56:52.844] Timer tick, asking Buildbucket for the build status
[09:56:53.069] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:53.069] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:76:0) after 1m0s
[09:57:53.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:76:0)
[09:57:53.098] Timer tick, asking Buildbucket for the build status
[09:57:53.334] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:53.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:77:0) after 1m0s
[09:58:53.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:77:0)
[09:58:53.372] Timer tick, asking Buildbucket for the build status
[09:58:53.574] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:53.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:78:0) after 1m0s
[09:59:53.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:78:0)
[09:59:53.620] Timer tick, asking Buildbucket for the build status
[09:59:56.130] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:56.130] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:79:0) after 1m0s
[10:00:56.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:79:0)
[10:00:56.203] Timer tick, asking Buildbucket for the build status
[10:00:56.812] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:56.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:80:0) after 1m0s
[10:01:56.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:80:0)
[10:01:56.968] Timer tick, asking Buildbucket for the build status
[10:01:57.216] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:57.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:81:0) after 1m0s
[10:02:57.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:81:0)
[10:02:57.341] Timer tick, asking Buildbucket for the build status
[10:02:57.608] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:57.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:82:0) after 1m0s
[10:03:57.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:82:0)
[10:03:57.609] Timer tick, asking Buildbucket for the build status
[10:03:57.760] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:57.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:83:0) after 1m0s
[10:04:57.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:83:0)
[10:04:57.833] Timer tick, asking Buildbucket for the build status
[10:04:57.968] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:57.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:84:0) after 1m0s
[10:05:58.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:84:0)
[10:05:58.028] Timer tick, asking Buildbucket for the build status
[10:05:58.608] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:58.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:85:0) after 1m0s
[10:06:58.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:85:0)
[10:06:58.682] Timer tick, asking Buildbucket for the build status
[10:06:59.034] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:59.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:86:0) after 1m0s
[10:07:59.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:86:0)
[10:07:59.085] Timer tick, asking Buildbucket for the build status
[10:07:59.396] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:59.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:87:0) after 1m0s
[10:08:59.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:87:0)
[10:08:59.470] Timer tick, asking Buildbucket for the build status
[10:08:59.810] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:59.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:88:0) after 1m0s
[10:09:59.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:88:0)
[10:09:59.884] Timer tick, asking Buildbucket for the build status
[10:10:00.209] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:00.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:89:0) after 1m0s
[10:11:00.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:89:0)
[10:11:00.298] Timer tick, asking Buildbucket for the build status
[10:11:00.413] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:00.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:90:0) after 1m0s
[10:12:00.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:90:0)
[10:12:00.565] Timer tick, asking Buildbucket for the build status
[10:12:00.967] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:00.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:91:0) after 1m0s
[10:13:01.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:91:0)
[10:13:01.037] Timer tick, asking Buildbucket for the build status
[10:13:01.212] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:01.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:92:0) after 1m0s
[10:14:01.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:92:0)
[10:14:01.385] Timer tick, asking Buildbucket for the build status
[10:14:01.556] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:01.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:93:0) after 1m0s
[10:15:01.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:93:0)
[10:15:01.653] Timer tick, asking Buildbucket for the build status
[10:15:02.056] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:02.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:94:0) after 1m0s
[10:16:02.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:94:0)
[10:16:02.099] Timer tick, asking Buildbucket for the build status
[10:16:02.241] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:02.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:95:0) after 1m0s
[10:17:02.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:95:0)
[10:17:02.372] Timer tick, asking Buildbucket for the build status
[10:17:02.513] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:02.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:96:0) after 1m0s
[10:18:02.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:96:0)
[10:18:02.540] Timer tick, asking Buildbucket for the build status
[10:18:02.867] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:02.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:97:0) after 1m0s
[10:19:02.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:97:0)
[10:19:02.895] Timer tick, asking Buildbucket for the build status
[10:19:03.241] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:03.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:98:0) after 1m0s
[10:20:03.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:98:0)
[10:20:03.315] Timer tick, asking Buildbucket for the build status
[10:20:03.433] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:03.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:99:0) after 1m0s
[10:21:03.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:99:0)
[10:21:03.461] Timer tick, asking Buildbucket for the build status
[10:21:03.667] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:03.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:100:0) after 1m0s
[10:22:03.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:100:0)
[10:22:03.691] Timer tick, asking Buildbucket for the build status
[10:22:03.821] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:03.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:101:0) after 1m0s
[10:23:03.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:101:0)
[10:23:03.853] Timer tick, asking Buildbucket for the build status
[10:23:04.052] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:04.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:102:0) after 1m0s
[10:24:04.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:102:0)
[10:24:04.117] Timer tick, asking Buildbucket for the build status
[10:24:04.553] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:04.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:103:0) after 1m0s
[10:25:04.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:103:0)
[10:25:04.580] Timer tick, asking Buildbucket for the build status
[10:25:04.778] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:04.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:104:0) after 1m0s
[10:26:04.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:104:0)
[10:26:04.833] Timer tick, asking Buildbucket for the build status
[10:26:04.961] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:04.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:105:0) after 1m0s
[10:27:04.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:105:0)
[10:27:04.992] Timer tick, asking Buildbucket for the build status
[10:27:05.186] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:05.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:106:0) after 1m0s
[10:28:05.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:106:0)
[10:28:05.267] Timer tick, asking Buildbucket for the build status
[10:28:05.466] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:05.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:107:0) after 1m0s
[10:29:05.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:107:0)
[10:29:05.495] Timer tick, asking Buildbucket for the build status
[10:29:06.129] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:06.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:108:0) after 1m0s
[10:30:06.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:108:0)
[10:30:06.152] Timer tick, asking Buildbucket for the build status
[10:30:06.463] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:06.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:109:0) after 1m0s
[10:31:06.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:109:0)
[10:31:06.558] Timer tick, asking Buildbucket for the build status
[10:31:06.760] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:06.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:110:0) after 1m0s
[10:32:06.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:110:0)
[10:32:06.811] Timer tick, asking Buildbucket for the build status
[10:32:08.228] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:08.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:111:0) after 1m0s
[10:33:08.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:111:0)
[10:33:08.302] Timer tick, asking Buildbucket for the build status
[10:33:08.593] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:08.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:112:0) after 1m0s
[10:34:08.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:112:0)
[10:34:08.765] Timer tick, asking Buildbucket for the build status
[10:34:08.895] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:08.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:113:0) after 1m0s
[10:35:08.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:113:0)
[10:35:08.947] Timer tick, asking Buildbucket for the build status
[10:35:09.486] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:09.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:114:0) after 1m0s
[10:36:09.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:114:0)
[10:36:09.575] Timer tick, asking Buildbucket for the build status
[10:36:09.720] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:09.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:115:0) after 1m0s
[10:37:09.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:115:0)
[10:37:09.767] Timer tick, asking Buildbucket for the build status
[10:37:10.253] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:10.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:116:0) after 1m0s
[10:38:10.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:116:0)
[10:38:10.281] Timer tick, asking Buildbucket for the build status
[10:38:10.590] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:10.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:117:0) after 1m0s
[10:39:10.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:117:0)
[10:39:10.623] Timer tick, asking Buildbucket for the build status
[10:39:10.859] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:10.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:118:0) after 1m0s
[10:40:11.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:118:0)
[10:40:11.033] Timer tick, asking Buildbucket for the build status
[10:40:11.374] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:11.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:119:0) after 1m0s
[10:41:11.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:119:0)
[10:41:11.409] Timer tick, asking Buildbucket for the build status
[10:41:11.557] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:11.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:120:0) after 1m0s
[10:42:11.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:120:0)
[10:42:11.588] Timer tick, asking Buildbucket for the build status
[10:42:11.876] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:11.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:121:0) after 1m0s
[10:43:11.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:121:0)
[10:43:11.993] Timer tick, asking Buildbucket for the build status
[10:43:12.542] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:12.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:122:0) after 1m0s
[10:44:12.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:122:0)
[10:44:12.945] Timer tick, asking Buildbucket for the build status
[10:44:13.358] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:13.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:123:0) after 1m0s
[10:45:13.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:123:0)
[10:45:13.438] Timer tick, asking Buildbucket for the build status
[10:45:13.577] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:13.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:124:0) after 1m0s
[10:46:13.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:124:0)
[10:46:13.675] Timer tick, asking Buildbucket for the build status
[10:46:13.812] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:13.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:125:0) after 1m0s
[10:47:13.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:125:0)
[10:47:13.838] Timer tick, asking Buildbucket for the build status
[10:47:14.242] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:14.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:126:0) after 1m0s
[10:48:14.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:126:0)
[10:48:14.275] Timer tick, asking Buildbucket for the build status
[10:48:14.457] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:14.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:127:0) after 1m0s
[10:49:14.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:127:0)
[10:49:14.552] Timer tick, asking Buildbucket for the build status
[10:49:14.790] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:14.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:128:0) after 1m0s
[10:50:15.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:128:0)
[10:50:15.032] Timer tick, asking Buildbucket for the build status
[10:50:15.277] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:15.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:129:0) after 1m0s
[10:51:15.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:129:0)
[10:51:15.403] Timer tick, asking Buildbucket for the build status
[10:51:15.812] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:15.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:130:0) after 1m0s
[10:52:16.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:130:0)
[10:52:16.066] Timer tick, asking Buildbucket for the build status
[10:52:16.187] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:16.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:131:0) after 1m0s
[10:53:22.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:131:0)
[10:53:22.317] Timer tick, asking Buildbucket for the build status
[10:53:22.822] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:22.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:132:0) after 1m0s
[10:54:22.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:132:0)
[10:54:22.846] Timer tick, asking Buildbucket for the build status
[10:54:22.964] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:22.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:133:0) after 1m0s
[10:55:22.990] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:133:0)
[10:55:22.990] Timer tick, asking Buildbucket for the build status
[10:55:23.126] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:23.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:134:0) after 1m0s
[10:56:23.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:134:0)
[10:56:23.182] Timer tick, asking Buildbucket for the build status
[10:56:23.343] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:23.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:135:0) after 1m0s
[10:57:23.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:135:0)
[10:57:23.386] Timer tick, asking Buildbucket for the build status
[10:57:23.613] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:23.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:136:0) after 1m0s
[10:58:23.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:136:0)
[10:58:23.658] Timer tick, asking Buildbucket for the build status
[10:58:23.971] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:23.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:137:0) after 1m0s
[10:59:23.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:137:0)
[10:59:23.994] Timer tick, asking Buildbucket for the build status
[10:59:24.203] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:24.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:138:0) after 1m0s
[11:00:24.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:138:0)
[11:00:24.250] Timer tick, asking Buildbucket for the build status
[11:00:24.378] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:24.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:139:0) after 1m0s
[11:01:24.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:139:0)
[11:01:24.475] Timer tick, asking Buildbucket for the build status
[11:01:25.189] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:25.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:140:0) after 1m0s
[11:02:25.220] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:140:0)
[11:02:25.220] Timer tick, asking Buildbucket for the build status
[11:02:25.347] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:25.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:141:0) after 1m0s
[11:03:25.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:141:0)
[11:03:25.389] Timer tick, asking Buildbucket for the build status
[11:03:25.559] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:25.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:142:0) after 1m0s
[11:04:25.643] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:142:0)
[11:04:25.643] Timer tick, asking Buildbucket for the build status
[11:04:25.825] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:25.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:143:0) after 1m0s
[11:05:25.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:143:0)
[11:05:25.830] Timer tick, asking Buildbucket for the build status
[11:05:25.955] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:25.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:144:0) after 1m0s
[11:06:25.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:144:0)
[11:06:25.986] Timer tick, asking Buildbucket for the build status
[11:06:26.153] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:26.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:145:0) after 1m0s
[11:07:26.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:145:0)
[11:07:26.237] Timer tick, asking Buildbucket for the build status
[11:07:26.370] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:26.370] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:146:0) after 1m0s
[11:08:26.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:146:0)
[11:08:26.396] Timer tick, asking Buildbucket for the build status
[11:08:26.815] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:26.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:147:0) after 1m0s
[11:09:26.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:147:0)
[11:09:26.894] Timer tick, asking Buildbucket for the build status
[11:09:27.326] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:27.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:148:0) after 1m0s
[11:10:27.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:148:0)
[11:10:27.355] Timer tick, asking Buildbucket for the build status
[11:10:27.524] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:27.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:149:0) after 1m0s
[11:11:27.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:149:0)
[11:11:27.553] Timer tick, asking Buildbucket for the build status
[11:11:27.955] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:27.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:150:0) after 1m0s
[11:12:27.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:150:0)
[11:12:27.972] Timer tick, asking Buildbucket for the build status
[11:12:28.521] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:28.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:151:0) after 1m0s
[11:13:28.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:151:0)
[11:13:28.558] Timer tick, asking Buildbucket for the build status
[11:13:29.134] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:29.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:152:0) after 1m0s
[11:14:29.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:152:0)
[11:14:29.177] Timer tick, asking Buildbucket for the build status
[11:14:29.700] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:29.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:153:0) after 1m0s
[11:15:29.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:153:0)
[11:15:29.727] Timer tick, asking Buildbucket for the build status
[11:15:29.868] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:29.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:154:0) after 1m0s
[11:16:29.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:154:0)
[11:16:29.899] Timer tick, asking Buildbucket for the build status
[11:16:30.251] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:30.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:155:0) after 1m0s
[11:17:30.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:155:0)
[11:17:30.315] Timer tick, asking Buildbucket for the build status
[11:17:30.679] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:30.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:156:0) after 1m0s
[11:18:30.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:156:0)
[11:18:30.708] Timer tick, asking Buildbucket for the build status
[11:18:31.172] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:31.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:157:0) after 1m0s
[11:19:31.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:157:0)
[11:19:31.205] Timer tick, asking Buildbucket for the build status
[11:19:31.570] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:31.570] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:158:0) after 1m0s
[11:20:31.598] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:158:0)
[11:20:31.598] Timer tick, asking Buildbucket for the build status
[11:20:32.056] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:32.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:159:0) after 1m0s
[11:21:32.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:159:0)
[11:21:32.200] Timer tick, asking Buildbucket for the build status
[11:21:32.649] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:32.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:160:0) after 1m0s
[11:22:32.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:160:0)
[11:22:32.693] Timer tick, asking Buildbucket for the build status
[11:22:33.166] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:33.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:161:0) after 1m0s
[11:23:33.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:161:0)
[11:23:33.193] Timer tick, asking Buildbucket for the build status
[11:23:33.334] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:33.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:162:0) after 1m0s
[11:24:33.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:162:0)
[11:24:33.370] Timer tick, asking Buildbucket for the build status
[11:24:33.728] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:33.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:163:0) after 1m0s
[11:25:33.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:163:0)
[11:25:33.806] Timer tick, asking Buildbucket for the build status
[11:25:33.924] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:33.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:164:0) after 1m0s
[11:26:33.952] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:164:0)
[11:26:33.952] Timer tick, asking Buildbucket for the build status
[11:26:34.648] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:34.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:165:0) after 1m0s
[11:27:34.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:165:0)
[11:27:34.675] Timer tick, asking Buildbucket for the build status
[11:27:34.771] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:34.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:166:0) after 1m0s
[11:28:34.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:166:0)
[11:28:34.796] Timer tick, asking Buildbucket for the build status
[11:28:34.987] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:34.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:167:0) after 1m0s
[11:29:35.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:167:0)
[11:29:35.018] Timer tick, asking Buildbucket for the build status
[11:29:35.439] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:35.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:168:0) after 1m0s
[11:30:35.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:168:0)
[11:30:35.602] Timer tick, asking Buildbucket for the build status
[11:30:35.967] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:35.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:169:0) after 1m0s
[11:31:36.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:169:0)
[11:31:36.075] Timer tick, asking Buildbucket for the build status
[11:31:36.347] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:36.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:170:0) after 1m0s
[11:32:36.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:170:0)
[11:32:36.386] Timer tick, asking Buildbucket for the build status
[11:32:36.972] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:36.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:171:0) after 1m0s
[11:33:37.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:171:0)
[11:33:37.027] Timer tick, asking Buildbucket for the build status
[11:33:37.207] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:37.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:172:0) after 1m0s
[11:34:37.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:172:0)
[11:34:37.268] Timer tick, asking Buildbucket for the build status
[11:34:37.548] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:37.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:173:0) after 1m0s
[11:35:37.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:173:0)
[11:35:37.576] Timer tick, asking Buildbucket for the build status
[11:35:37.787] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:37.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:174:0) after 1m0s
[11:36:37.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:174:0)
[11:36:37.815] Timer tick, asking Buildbucket for the build status
[11:36:38.049] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:38.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:175:0) after 1m0s
[11:37:38.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:175:0)
[11:37:38.088] Timer tick, asking Buildbucket for the build status
[11:37:38.476] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:38.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:176:0) after 1m0s
[11:38:38.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:176:0)
[11:38:38.618] Timer tick, asking Buildbucket for the build status
[11:38:38.739] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:38.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:177:0) after 1m0s
[11:39:38.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:177:0)
[11:39:38.816] Timer tick, asking Buildbucket for the build status
[11:39:39.006] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:39.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:178:0) after 1m0s
[11:40:39.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:178:0)
[11:40:39.093] Timer tick, asking Buildbucket for the build status
[11:40:39.297] Build 8879523623882249376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:39.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044953685890001216:179:0) after 1m0s
[11:41:02.957] Received PubSub notification, asking Buildbucket for the build status
[11:41:03.293] Build 8879523623882249376: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:41:03.293] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1590234062085727",
    "created_by": "project:infra",
    "created_ts": "1590223400188823",
    "id": "8879523623882249376",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4153.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"c9443356-1e69-4c52-a974-bc10995f23bc\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4153.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4153.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"c9443356-1e69-4c52-a974-bc10995f23bc\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-0o9h\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"85.0.4153.0\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-0o9h\"], \"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": "1590223433433641",
    "status": "COMPLETED",
    "status_changed_ts": "1590234062492809",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9044953685890001216",
      "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/8879523623882249376/+/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:4c5984f822139d10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1590234062535613",
    "url": "https://ci.chromium.org/b/8879523623882249376",
    "utcnow_ts": "1590234063232702"
  }
}
[11:41:03.293] Invocation finished in 2h57m44.40312119s with status SUCCEEDED