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

• parent_buildername:publish_tarball
• user_agent:recipe

[07:51:08.228] New invocation is queued and will start shortly
[07:51:08.228] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[07:51:09.318] Starting the invocation (attempt 1)
[07:51:09.359] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:51:09.359] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:51:09.359] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9036078465941938656",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"87.0.4248.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"aba55315-1e62-4d26-b610-90eb2c828854\",\"title\":\"publish_tarball/0\"}]},\"version\":\"87.0.4248.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:9036078465941938656",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[07:51:09.933] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1598687469448616",
    "id": "8870648403994014688",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4248.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"aba55315-1e62-4d26-b610-90eb2c828854\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4248.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1598687469670266",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9036078465941938656",
      "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/8870648403994014688/+/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": "1598687469670421",
    "url": "https://ci.chromium.org/b/8870648403994014688",
    "utcnow_ts": "1598687469923846"
  }
}
[07:51:09.933] Task URL: https://ci.chromium.org/b/8870648403994014688
[07:51:09.933] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:2:0) after 1m0s
[07:52:09.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:2:0)
[07:52:09.938] Timer tick, asking Buildbucket for the build status
[07:52:10.062] Build 8870648403994014688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:52:10.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:3:0) after 1m0s
[07:52:15.551] Received PubSub notification, asking Buildbucket for the build status
[07:52:15.693] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:10.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:3:0)
[07:53:10.068] Timer tick, asking Buildbucket for the build status
[07:53:10.492] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:10.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:5:0) after 1m0s
[07:54:10.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:5:0)
[07:54:10.580] Timer tick, asking Buildbucket for the build status
[07:54:10.891] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:10.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:6:0) after 1m0s
[07:55:10.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:6:0)
[07:55:10.912] Timer tick, asking Buildbucket for the build status
[07:55:11.619] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:11.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:7:0) after 1m0s
[07:56:11.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:7:0)
[07:56:11.688] Timer tick, asking Buildbucket for the build status
[07:56:11.765] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:11.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:8:0) after 1m0s
[07:57:11.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:8:0)
[07:57:11.751] Timer tick, asking Buildbucket for the build status
[07:57:11.887] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:11.887] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:9:0) after 1m0s
[07:58:11.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:9:0)
[07:58:11.940] Timer tick, asking Buildbucket for the build status
[07:58:12.208] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:12.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:10:0) after 1m0s
[07:59:12.229] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:10:0)
[07:59:12.229] Timer tick, asking Buildbucket for the build status
[07:59:12.324] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:12.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:11:0) after 1m0s
[08:00:12.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:11:0)
[08:00:12.416] Timer tick, asking Buildbucket for the build status
[08:00:12.481] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:12.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:12:0) after 1m0s
[08:01:12.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:12:0)
[08:01:12.462] Timer tick, asking Buildbucket for the build status
[08:01:12.622] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:12.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:13:0) after 1m0s
[08:02:12.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:13:0)
[08:02:12.681] Timer tick, asking Buildbucket for the build status
[08:02:12.796] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:12.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:14:0) after 1m0s
[08:03:12.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:14:0)
[08:03:12.848] Timer tick, asking Buildbucket for the build status
[08:03:13.087] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:13.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:15:0) after 1m0s
[08:04:13.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:15:0)
[08:04:13.182] Timer tick, asking Buildbucket for the build status
[08:04:13.281] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:13.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:16:0) after 1m0s
[08:05:13.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:16:0)
[08:05:13.361] Timer tick, asking Buildbucket for the build status
[08:05:13.642] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:13.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:17:0) after 1m0s
[08:06:13.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:17:0)
[08:06:13.701] Timer tick, asking Buildbucket for the build status
[08:06:13.768] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:13.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:18:0) after 1m0s
[08:07:13.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:18:0)
[08:07:13.823] Timer tick, asking Buildbucket for the build status
[08:07:13.948] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:13.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:19:0) after 1m0s
[08:08:14.120] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:19:0)
[08:08:14.120] Timer tick, asking Buildbucket for the build status
[08:08:14.221] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:14.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:20:0) after 1m0s
[08:09:14.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:20:0)
[08:09:14.306] Timer tick, asking Buildbucket for the build status
[08:09:14.445] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:14.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:21:0) after 1m0s
[08:10:14.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:21:0)
[08:10:14.516] Timer tick, asking Buildbucket for the build status
[08:10:14.656] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:14.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:22:0) after 1m0s
[08:11:14.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:22:0)
[08:11:14.645] Timer tick, asking Buildbucket for the build status
[08:11:14.766] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:14.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:23:0) after 1m0s
[08:12:14.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:23:0)
[08:12:14.824] Timer tick, asking Buildbucket for the build status
[08:12:15.046] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:15.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:24:0) after 1m0s
[08:13:15.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:24:0)
[08:13:15.026] Timer tick, asking Buildbucket for the build status
[08:13:15.518] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:15.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:25:0) after 1m0s
[08:14:15.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:25:0)
[08:14:15.622] Timer tick, asking Buildbucket for the build status
[08:14:15.819] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:15.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:26:0) after 1m0s
[08:15:15.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:26:0)
[08:15:15.858] Timer tick, asking Buildbucket for the build status
[08:15:15.953] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:15.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:27:0) after 1m0s
[08:16:16.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:27:0)
[08:16:16.004] Timer tick, asking Buildbucket for the build status
[08:16:16.223] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:16.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:28:0) after 1m0s
[08:17:16.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:28:0)
[08:17:16.247] Timer tick, asking Buildbucket for the build status
[08:17:16.329] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:16.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:29:0) after 1m0s
[08:18:16.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:29:0)
[08:18:16.367] Timer tick, asking Buildbucket for the build status
[08:18:16.461] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:16.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:30:0) after 1m0s
[08:19:16.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:30:0)
[08:19:16.507] Timer tick, asking Buildbucket for the build status
[08:19:16.659] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:16.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:31:0) after 1m0s
[08:20:16.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:31:0)
[08:20:16.762] Timer tick, asking Buildbucket for the build status
[08:20:16.887] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:16.887] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:32:0) after 1m0s
[08:21:16.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:32:0)
[08:21:16.907] Timer tick, asking Buildbucket for the build status
[08:21:17.017] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:17.017] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:33:0) after 1m0s
[08:22:17.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:33:0)
[08:22:17.055] Timer tick, asking Buildbucket for the build status
[08:22:17.128] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:17.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:34:0) after 1m0s
[08:23:17.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:34:0)
[08:23:17.129] Timer tick, asking Buildbucket for the build status
[08:23:17.304] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:17.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:35:0) after 1m0s
[08:24:17.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:35:0)
[08:24:17.445] Timer tick, asking Buildbucket for the build status
[08:24:17.699] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:17.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:36:0) after 1m0s
[08:25:17.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:36:0)
[08:25:17.748] Timer tick, asking Buildbucket for the build status
[08:25:18.227] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:18.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:37:0) after 1m0s
[08:26:18.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:37:0)
[08:26:18.252] Timer tick, asking Buildbucket for the build status
[08:26:18.453] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:18.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:38:0) after 1m0s
[08:27:18.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:38:0)
[08:27:18.477] Timer tick, asking Buildbucket for the build status
[08:27:18.576] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:18.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:39:0) after 1m0s
[08:28:18.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:39:0)
[08:28:18.583] Timer tick, asking Buildbucket for the build status
[08:28:18.882] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:18.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:40:0) after 1m0s
[08:29:18.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:40:0)
[08:29:18.912] Timer tick, asking Buildbucket for the build status
[08:29:19.196] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:19.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:41:0) after 1m0s
[08:30:19.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:41:0)
[08:30:19.251] Timer tick, asking Buildbucket for the build status
[08:30:19.338] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:19.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:42:0) after 1m0s
[08:31:19.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:42:0)
[08:31:19.387] Timer tick, asking Buildbucket for the build status
[08:31:19.696] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:19.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:43:0) after 1m0s
[08:32:19.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:43:0)
[08:32:19.726] Timer tick, asking Buildbucket for the build status
[08:32:19.930] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:19.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:44:0) after 1m0s
[08:33:20.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:44:0)
[08:33:20.158] Timer tick, asking Buildbucket for the build status
[08:33:20.251] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:20.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:45:0) after 1m0s
[08:34:20.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:45:0)
[08:34:20.325] Timer tick, asking Buildbucket for the build status
[08:34:20.541] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:20.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:46:0) after 1m0s
[08:35:20.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:46:0)
[08:35:20.650] Timer tick, asking Buildbucket for the build status
[08:35:20.744] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:20.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:47:0) after 1m0s
[08:36:20.781] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:47:0)
[08:36:20.781] Timer tick, asking Buildbucket for the build status
[08:36:22.242] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:22.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:48:0) after 1m0s
[08:37:22.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:48:0)
[08:37:22.267] Timer tick, asking Buildbucket for the build status
[08:37:22.343] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:22.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:49:0) after 1m0s
[08:38:22.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:49:0)
[08:38:22.463] Timer tick, asking Buildbucket for the build status
[08:38:22.832] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:22.832] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:50:0) after 1m0s
[08:39:22.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:50:0)
[08:39:22.875] Timer tick, asking Buildbucket for the build status
[08:39:22.959] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:22.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:51:0) after 1m0s
[08:40:23.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:51:0)
[08:40:23.071] Timer tick, asking Buildbucket for the build status
[08:40:23.386] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:23.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:52:0) after 1m0s
[08:41:23.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:52:0)
[08:41:23.427] Timer tick, asking Buildbucket for the build status
[08:41:23.621] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:23.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:53:0) after 1m0s
[08:42:23.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:53:0)
[08:42:23.650] Timer tick, asking Buildbucket for the build status
[08:42:24.684] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:24.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:54:0) after 1m0s
[08:43:24.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:54:0)
[08:43:24.707] Timer tick, asking Buildbucket for the build status
[08:43:24.792] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:24.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:55:0) after 1m0s
[08:44:24.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:55:0)
[08:44:24.912] Timer tick, asking Buildbucket for the build status
[08:44:24.985] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:24.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:56:0) after 1m0s
[08:45:25.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:56:0)
[08:45:25.205] Timer tick, asking Buildbucket for the build status
[08:45:25.278] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:25.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:57:0) after 1m0s
[08:46:25.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:57:0)
[08:46:25.337] Timer tick, asking Buildbucket for the build status
[08:46:25.463] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:25.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:58:0) after 1m0s
[08:47:25.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:58:0)
[08:47:25.523] Timer tick, asking Buildbucket for the build status
[08:47:25.643] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:25.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:59:0) after 1m0s
[08:48:25.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:59:0)
[08:48:25.692] Timer tick, asking Buildbucket for the build status
[08:48:25.775] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:25.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:60:0) after 1m0s
[08:49:26.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:60:0)
[08:49:26.086] Timer tick, asking Buildbucket for the build status
[08:49:26.144] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:26.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:61:0) after 1m0s
[08:50:26.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:61:0)
[08:50:26.187] Timer tick, asking Buildbucket for the build status
[08:50:26.253] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:26.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:62:0) after 1m0s
[08:51:26.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:62:0)
[08:51:26.393] Timer tick, asking Buildbucket for the build status
[08:51:26.497] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:26.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:63:0) after 1m0s
[08:52:26.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:63:0)
[08:52:26.620] Timer tick, asking Buildbucket for the build status
[08:52:26.735] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:26.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:64:0) after 1m0s
[08:53:26.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:64:0)
[08:53:26.747] Timer tick, asking Buildbucket for the build status
[08:53:26.849] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:26.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:65:0) after 1m0s
[08:54:26.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:65:0)
[08:54:26.918] Timer tick, asking Buildbucket for the build status
[08:54:27.014] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:27.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:66:0) after 1m0s
[08:55:27.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:66:0)
[08:55:27.111] Timer tick, asking Buildbucket for the build status
[08:55:27.221] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:27.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:67:0) after 1m0s
[08:56:27.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:67:0)
[08:56:27.276] Timer tick, asking Buildbucket for the build status
[08:56:27.423] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:27.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:68:0) after 1m0s
[08:57:27.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:68:0)
[08:57:27.497] Timer tick, asking Buildbucket for the build status
[08:57:27.556] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:27.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:69:0) after 1m0s
[08:58:27.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:69:0)
[08:58:27.698] Timer tick, asking Buildbucket for the build status
[08:58:27.786] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:27.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:70:0) after 1m0s
[08:59:27.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:70:0)
[08:59:27.901] Timer tick, asking Buildbucket for the build status
[08:59:27.978] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:27.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:71:0) after 1m0s
[09:00:28.015] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:71:0)
[09:00:28.015] Timer tick, asking Buildbucket for the build status
[09:00:28.098] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:28.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:72:0) after 1m0s
[09:01:28.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:72:0)
[09:01:28.091] Timer tick, asking Buildbucket for the build status
[09:01:28.408] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:28.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:73:0) after 1m0s
[09:02:28.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:73:0)
[09:02:28.574] Timer tick, asking Buildbucket for the build status
[09:02:28.684] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:28.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:74:0) after 1m0s
[09:03:28.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:74:0)
[09:03:28.805] Timer tick, asking Buildbucket for the build status
[09:03:28.899] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:28.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:75:0) after 1m0s
[09:04:28.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:75:0)
[09:04:28.901] Timer tick, asking Buildbucket for the build status
[09:04:29.079] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:29.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:76:0) after 1m0s
[09:05:29.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:76:0)
[09:05:29.122] Timer tick, asking Buildbucket for the build status
[09:05:29.189] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:29.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:77:0) after 1m0s
[09:06:29.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:77:0)
[09:06:29.228] Timer tick, asking Buildbucket for the build status
[09:06:29.369] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:29.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:78:0) after 1m0s
[09:07:29.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:78:0)
[09:07:29.411] Timer tick, asking Buildbucket for the build status
[09:07:29.490] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:29.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:79:0) after 1m0s
[09:08:29.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:79:0)
[09:08:29.525] Timer tick, asking Buildbucket for the build status
[09:08:29.741] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:29.741] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:80:0) after 1m0s
[09:09:29.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:80:0)
[09:09:29.837] Timer tick, asking Buildbucket for the build status
[09:09:30.389] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:30.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:81:0) after 1m0s
[09:10:30.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:81:0)
[09:10:30.503] Timer tick, asking Buildbucket for the build status
[09:10:30.712] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:30.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:82:0) after 1m0s
[09:11:30.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:82:0)
[09:11:30.736] Timer tick, asking Buildbucket for the build status
[09:11:30.864] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:30.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:83:0) after 1m0s
[09:12:30.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:83:0)
[09:12:30.916] Timer tick, asking Buildbucket for the build status
[09:12:31.213] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:31.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:84:0) after 1m0s
[09:13:31.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:84:0)
[09:13:31.239] Timer tick, asking Buildbucket for the build status
[09:13:31.325] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:31.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:85:0) after 1m0s
[09:14:31.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:85:0)
[09:14:31.377] Timer tick, asking Buildbucket for the build status
[09:14:31.485] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:31.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:86:0) after 1m0s
[09:15:31.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:86:0)
[09:15:31.552] Timer tick, asking Buildbucket for the build status
[09:15:32.605] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:32.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:87:0) after 1m0s
[09:16:32.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:87:0)
[09:16:32.689] Timer tick, asking Buildbucket for the build status
[09:16:32.891] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:32.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:88:0) after 1m0s
[09:17:32.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:88:0)
[09:17:32.936] Timer tick, asking Buildbucket for the build status
[09:17:33.006] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:33.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:89:0) after 1m0s
[09:18:33.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:89:0)
[09:18:33.214] Timer tick, asking Buildbucket for the build status
[09:18:33.349] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:33.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:90:0) after 1m0s
[09:19:33.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:90:0)
[09:19:33.340] Timer tick, asking Buildbucket for the build status
[09:19:33.425] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:33.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:91:0) after 1m0s
[09:20:33.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:91:0)
[09:20:33.510] Timer tick, asking Buildbucket for the build status
[09:20:33.977] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:33.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:92:0) after 1m0s
[09:21:34.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:92:0)
[09:21:34.259] Timer tick, asking Buildbucket for the build status
[09:21:34.423] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:34.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:93:0) after 1m0s
[09:22:34.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:93:0)
[09:22:34.639] Timer tick, asking Buildbucket for the build status
[09:22:34.733] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:34.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:94:0) after 1m0s
[09:23:34.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:94:0)
[09:23:34.908] Timer tick, asking Buildbucket for the build status
[09:23:34.974] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:34.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:95:0) after 1m0s
[09:24:35.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:95:0)
[09:24:35.426] Timer tick, asking Buildbucket for the build status
[09:24:35.655] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:35.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:96:0) after 1m0s
[09:25:35.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:96:0)
[09:25:35.757] Timer tick, asking Buildbucket for the build status
[09:25:35.841] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:35.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:97:0) after 1m0s
[09:26:35.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:97:0)
[09:26:35.977] Timer tick, asking Buildbucket for the build status
[09:26:36.402] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:36.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:98:0) after 1m0s
[09:27:36.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:98:0)
[09:27:36.465] Timer tick, asking Buildbucket for the build status
[09:27:36.645] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:36.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:99:0) after 1m0s
[09:28:37.130] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:99:0)
[09:28:37.131] Timer tick, asking Buildbucket for the build status
[09:28:37.441] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:37.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:100:0) after 1m0s
[09:29:37.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:100:0)
[09:29:37.566] Timer tick, asking Buildbucket for the build status
[09:29:37.651] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:37.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:101:0) after 1m0s
[09:30:37.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:101:0)
[09:30:37.745] Timer tick, asking Buildbucket for the build status
[09:30:37.851] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:37.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:102:0) after 1m0s
[09:31:37.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:102:0)
[09:31:37.895] Timer tick, asking Buildbucket for the build status
[09:31:38.034] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:38.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:103:0) after 1m0s
[09:32:38.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:103:0)
[09:32:38.103] Timer tick, asking Buildbucket for the build status
[09:32:38.175] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:38.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:104:0) after 1m0s
[09:33:38.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:104:0)
[09:33:38.361] Timer tick, asking Buildbucket for the build status
[09:33:38.427] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:38.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:105:0) after 1m0s
[09:34:38.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:105:0)
[09:34:38.811] Timer tick, asking Buildbucket for the build status
[09:34:38.902] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:38.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:106:0) after 1m0s
[09:35:38.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:106:0)
[09:35:38.967] Timer tick, asking Buildbucket for the build status
[09:35:39.042] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:39.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:107:0) after 1m0s
[09:36:39.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:107:0)
[09:36:39.087] Timer tick, asking Buildbucket for the build status
[09:36:39.232] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:39.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:108:0) after 1m0s
[09:37:39.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:108:0)
[09:37:39.251] Timer tick, asking Buildbucket for the build status
[09:37:39.333] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:39.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:109:0) after 1m0s
[09:38:39.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:109:0)
[09:38:39.398] Timer tick, asking Buildbucket for the build status
[09:38:39.480] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:39.480] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:110:0) after 1m0s
[09:39:39.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:110:0)
[09:39:39.570] Timer tick, asking Buildbucket for the build status
[09:39:39.796] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:39.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:111:0) after 1m0s
[09:40:39.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:111:0)
[09:40:39.985] Timer tick, asking Buildbucket for the build status
[09:40:40.124] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:40.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:112:0) after 1m0s
[09:41:40.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:112:0)
[09:41:40.224] Timer tick, asking Buildbucket for the build status
[09:41:40.347] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:40.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:113:0) after 1m0s
[09:42:40.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:113:0)
[09:42:40.496] Timer tick, asking Buildbucket for the build status
[09:42:40.783] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:40.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:114:0) after 1m0s
[09:43:40.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:114:0)
[09:43:40.981] Timer tick, asking Buildbucket for the build status
[09:43:41.044] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:41.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:115:0) after 1m0s
[09:44:41.081] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:115:0)
[09:44:41.081] Timer tick, asking Buildbucket for the build status
[09:44:41.176] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:41.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:116:0) after 1m0s
[09:45:41.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:116:0)
[09:45:41.405] Timer tick, asking Buildbucket for the build status
[09:45:41.498] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:41.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:117:0) after 1m0s
[09:46:41.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:117:0)
[09:46:41.540] Timer tick, asking Buildbucket for the build status
[09:46:41.749] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:41.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:118:0) after 1m0s
[09:47:41.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:118:0)
[09:47:41.773] Timer tick, asking Buildbucket for the build status
[09:47:41.998] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:41.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:119:0) after 1m0s
[09:48:41.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:119:0)
[09:48:41.999] Timer tick, asking Buildbucket for the build status
[09:48:42.370] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:42.370] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:120:0) after 1m0s
[09:49:42.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:120:0)
[09:49:42.394] Timer tick, asking Buildbucket for the build status
[09:49:42.826] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:42.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:121:0) after 1m0s
[09:50:42.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:121:0)
[09:50:42.915] Timer tick, asking Buildbucket for the build status
[09:50:43.051] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:43.051] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:122:0) after 1m0s
[09:51:43.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:122:0)
[09:51:43.084] Timer tick, asking Buildbucket for the build status
[09:51:43.281] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:43.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:123:0) after 1m0s
[09:52:43.305] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:123:0)
[09:52:43.305] Timer tick, asking Buildbucket for the build status
[09:52:43.371] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:43.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:124:0) after 1m0s
[09:53:43.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:124:0)
[09:53:43.414] Timer tick, asking Buildbucket for the build status
[09:53:43.629] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:43.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:125:0) after 1m0s
[09:54:43.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:125:0)
[09:54:43.678] Timer tick, asking Buildbucket for the build status
[09:54:43.845] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:43.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:126:0) after 1m0s
[09:55:43.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:126:0)
[09:55:43.880] Timer tick, asking Buildbucket for the build status
[09:55:44.165] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:44.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:127:0) after 1m0s
[09:56:44.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:127:0)
[09:56:44.191] Timer tick, asking Buildbucket for the build status
[09:56:44.365] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:44.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:128:0) after 1m0s
[09:57:44.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:128:0)
[09:57:44.498] Timer tick, asking Buildbucket for the build status
[09:57:44.561] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:44.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:129:0) after 1m0s
[09:58:44.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:129:0)
[09:58:44.757] Timer tick, asking Buildbucket for the build status
[09:58:45.012] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:45.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:130:0) after 1m0s
[09:59:45.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:130:0)
[09:59:45.087] Timer tick, asking Buildbucket for the build status
[09:59:45.180] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:45.180] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:131:0) after 1m0s
[10:00:45.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:131:0)
[10:00:45.262] Timer tick, asking Buildbucket for the build status
[10:00:45.352] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:45.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:132:0) after 1m0s
[10:01:45.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:132:0)
[10:01:45.387] Timer tick, asking Buildbucket for the build status
[10:01:46.721] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:46.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:133:0) after 1m0s
[10:02:46.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:133:0)
[10:02:46.755] Timer tick, asking Buildbucket for the build status
[10:02:46.828] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:46.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:134:0) after 1m0s
[10:03:46.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:134:0)
[10:03:46.898] Timer tick, asking Buildbucket for the build status
[10:03:46.965] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:46.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:135:0) after 1m0s
[10:04:46.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:135:0)
[10:04:46.968] Timer tick, asking Buildbucket for the build status
[10:04:47.140] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:47.140] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:136:0) after 1m0s
[10:05:47.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:136:0)
[10:05:47.169] Timer tick, asking Buildbucket for the build status
[10:05:47.219] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:47.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:137:0) after 1m0s
[10:06:47.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:137:0)
[10:06:47.281] Timer tick, asking Buildbucket for the build status
[10:06:47.464] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:47.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:138:0) after 1m0s
[10:07:47.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:138:0)
[10:07:47.527] Timer tick, asking Buildbucket for the build status
[10:07:47.610] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:47.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:139:0) after 1m0s
[10:08:47.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:139:0)
[10:08:47.703] Timer tick, asking Buildbucket for the build status
[10:08:47.816] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:47.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:140:0) after 1m0s
[10:09:47.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:140:0)
[10:09:47.843] Timer tick, asking Buildbucket for the build status
[10:09:47.907] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:47.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:141:0) after 1m0s
[10:10:47.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:141:0)
[10:10:47.985] Timer tick, asking Buildbucket for the build status
[10:10:48.072] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:48.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:142:0) after 1m0s
[10:11:48.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:142:0)
[10:11:48.104] Timer tick, asking Buildbucket for the build status
[10:11:48.392] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:48.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:143:0) after 1m0s
[10:12:48.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:143:0)
[10:12:48.420] Timer tick, asking Buildbucket for the build status
[10:12:48.504] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:48.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:144:0) after 1m0s
[10:13:48.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:144:0)
[10:13:48.531] Timer tick, asking Buildbucket for the build status
[10:13:48.643] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:48.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:145:0) after 1m0s
[10:14:48.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:145:0)
[10:14:48.678] Timer tick, asking Buildbucket for the build status
[10:14:48.758] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:48.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:146:0) after 1m0s
[10:15:48.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:146:0)
[10:15:48.839] Timer tick, asking Buildbucket for the build status
[10:15:49.003] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:49.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:147:0) after 1m0s
[10:16:49.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:147:0)
[10:16:49.036] Timer tick, asking Buildbucket for the build status
[10:16:50.580] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:50.580] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:148:0) after 1m0s
[10:17:50.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:148:0)
[10:17:50.669] Timer tick, asking Buildbucket for the build status
[10:17:50.731] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:50.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:149:0) after 1m0s
[10:18:50.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:149:0)
[10:18:50.763] Timer tick, asking Buildbucket for the build status
[10:18:50.909] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:50.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:150:0) after 1m0s
[10:19:50.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:150:0)
[10:19:50.969] Timer tick, asking Buildbucket for the build status
[10:19:52.660] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:52.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:151:0) after 1m0s
[10:20:52.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:151:0)
[10:20:52.733] Timer tick, asking Buildbucket for the build status
[10:20:52.798] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:52.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:152:0) after 1m0s
[10:21:52.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:152:0)
[10:21:52.885] Timer tick, asking Buildbucket for the build status
[10:21:53.068] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:53.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:153:0) after 1m0s
[10:22:53.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:153:0)
[10:22:53.099] Timer tick, asking Buildbucket for the build status
[10:22:53.214] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:53.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:154:0) after 1m0s
[10:23:53.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:154:0)
[10:23:53.259] Timer tick, asking Buildbucket for the build status
[10:23:53.435] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:53.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:155:0) after 1m0s
[10:24:53.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:155:0)
[10:24:53.528] Timer tick, asking Buildbucket for the build status
[10:24:54.072] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:54.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:156:0) after 1m0s
[10:25:54.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:156:0)
[10:25:54.099] Timer tick, asking Buildbucket for the build status
[10:25:54.309] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:54.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:157:0) after 1m0s
[10:26:54.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:157:0)
[10:26:54.347] Timer tick, asking Buildbucket for the build status
[10:26:54.501] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:54.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:158:0) after 1m0s
[10:27:54.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:158:0)
[10:27:54.628] Timer tick, asking Buildbucket for the build status
[10:27:54.691] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:54.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:159:0) after 1m0s
[10:28:54.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:159:0)
[10:28:54.732] Timer tick, asking Buildbucket for the build status
[10:28:54.801] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:54.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:160:0) after 1m0s
[10:29:54.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:160:0)
[10:29:54.829] Timer tick, asking Buildbucket for the build status
[10:29:54.887] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:54.887] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:161:0) after 1m0s
[10:30:54.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:161:0)
[10:30:54.904] Timer tick, asking Buildbucket for the build status
[10:30:55.463] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:55.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:162:0) after 1m0s
[10:31:55.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:162:0)
[10:31:55.498] Timer tick, asking Buildbucket for the build status
[10:31:55.612] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:55.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:163:0) after 1m0s
[10:32:55.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:163:0)
[10:32:55.659] Timer tick, asking Buildbucket for the build status
[10:32:55.758] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:55.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:164:0) after 1m0s
[10:33:55.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:164:0)
[10:33:55.784] Timer tick, asking Buildbucket for the build status
[10:33:55.880] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:55.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:165:0) after 1m0s
[10:34:55.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:165:0)
[10:34:55.913] Timer tick, asking Buildbucket for the build status
[10:34:56.277] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:56.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:166:0) after 1m0s
[10:35:56.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:166:0)
[10:35:56.306] Timer tick, asking Buildbucket for the build status
[10:35:56.397] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:56.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:167:0) after 1m0s
[10:36:56.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:167:0)
[10:36:56.474] Timer tick, asking Buildbucket for the build status
[10:36:56.721] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:56.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:168:0) after 1m0s
[10:37:56.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:168:0)
[10:37:56.805] Timer tick, asking Buildbucket for the build status
[10:37:57.248] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:57.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:169:0) after 1m0s
[10:38:57.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:169:0)
[10:38:57.295] Timer tick, asking Buildbucket for the build status
[10:38:57.384] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:57.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:170:0) after 1m0s
[10:39:57.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:170:0)
[10:39:57.476] Timer tick, asking Buildbucket for the build status
[10:39:57.543] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:57.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:171:0) after 1m0s
[10:40:57.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:171:0)
[10:40:57.579] Timer tick, asking Buildbucket for the build status
[10:40:57.657] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:57.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:172:0) after 1m0s
[10:41:57.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:172:0)
[10:41:57.681] Timer tick, asking Buildbucket for the build status
[10:41:58.729] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:58.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:173:0) after 1m0s
[10:42:58.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:173:0)
[10:42:58.917] Timer tick, asking Buildbucket for the build status
[10:42:58.990] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:58.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:174:0) after 1m0s
[10:43:59.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:174:0)
[10:43:59.155] Timer tick, asking Buildbucket for the build status
[10:43:59.286] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:59.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:175:0) after 1m0s
[10:44:59.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:175:0)
[10:44:59.490] Timer tick, asking Buildbucket for the build status
[10:44:59.759] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:59.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:176:0) after 1m0s
[10:45:59.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:176:0)
[10:45:59.796] Timer tick, asking Buildbucket for the build status
[10:46:00.096] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:00.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:177:0) after 1m0s
[10:47:00.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:177:0)
[10:47:00.124] Timer tick, asking Buildbucket for the build status
[10:47:00.249] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:00.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:178:0) after 1m0s
[10:48:00.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:178:0)
[10:48:00.276] Timer tick, asking Buildbucket for the build status
[10:48:00.335] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:00.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:179:0) after 1m0s
[10:49:00.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:179:0)
[10:49:00.430] Timer tick, asking Buildbucket for the build status
[10:49:00.508] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:00.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:180:0) after 1m0s
[10:50:00.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:180:0)
[10:50:00.537] Timer tick, asking Buildbucket for the build status
[10:50:00.813] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:00.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:181:0) after 1m0s
[10:51:00.826] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:181:0)
[10:51:00.826] Timer tick, asking Buildbucket for the build status
[10:51:00.900] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:00.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:182:0) after 1m0s
[10:52:01.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:182:0)
[10:52:01.458] Timer tick, asking Buildbucket for the build status
[10:52:01.814] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:01.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:183:0) after 1m0s
[10:53:01.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:183:0)
[10:53:01.850] Timer tick, asking Buildbucket for the build status
[10:53:01.920] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:01.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:184:0) after 1m0s
[10:54:01.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:184:0)
[10:54:01.955] Timer tick, asking Buildbucket for the build status
[10:54:02.091] Build 8870648403994014688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:02.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036078465941938656:185:0) after 1m0s
[10:54:39.478] Received PubSub notification, asking Buildbucket for the build status
[10:54:39.553] Build 8870648403994014688: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:54:39.553] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1598698478673441",
    "created_by": "project:infra",
    "created_ts": "1598687469448616",
    "id": "8870648403994014688",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4248.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"aba55315-1e62-4d26-b610-90eb2c828854\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4248.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-0xxv\"], \"image\": [\"chrome-xenial-20081700-d9392568d25\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5498-3454aa6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1598687534399510",
    "status": "COMPLETED",
    "status_changed_ts": "1598698479073215",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9036078465941938656",
      "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/8870648403994014688/+/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:4e52046e1ce9b910",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1598698479183523",
    "url": "https://ci.chromium.org/b/8870648403994014688",
    "utcnow_ts": "1598698479544498"
  }
}
[10:54:39.553] Invocation finished in 3h3m31.34627869s with status SUCCEEDED