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

• parent_buildername:publish_tarball
• user_agent:recipe

[02:22:33.198] New invocation is queued and will start shortly
[02:22:33.198] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[02:22:34.478] Starting the invocation (attempt 1)
[02:22:34.529] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:22:34.529] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:22:34.529] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9034558990219756064",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"87.0.4263.3\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"d1bf57c4-ced8-4351-a806-0791a5715418\",\"title\":\"publish_tarball/0\"}]},\"version\":\"87.0.4263.3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9034558990219756064",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[02:22:34.942] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1600136554633198",
    "id": "8869128928047359200",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4263.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"d1bf57c4-ced8-4351-a806-0791a5715418\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4263.3\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1600136554818117",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9034558990219756064",
      "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/8869128928047359200/+/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": "1600136554818239",
    "url": "https://ci.chromium.org/b/8869128928047359200",
    "utcnow_ts": "1600136554926755"
  }
}
[02:22:34.942] Task URL: https://ci.chromium.org/b/8869128928047359200
[02:22:34.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:2:0) after 1m0s
[02:23:35.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:2:0)
[02:23:35.155] Timer tick, asking Buildbucket for the build status
[02:23:35.356] Build 8869128928047359200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:35.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:3:0) after 1m0s
[02:23:36.056] Received PubSub notification, asking Buildbucket for the build status
[02:23:36.164] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:35.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:3:0)
[02:24:35.428] Timer tick, asking Buildbucket for the build status
[02:24:35.642] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:35.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:5:0) after 1m0s
[02:25:35.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:5:0)
[02:25:35.658] Timer tick, asking Buildbucket for the build status
[02:25:35.772] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:35.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:6:0) after 1m0s
[02:26:35.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:6:0)
[02:26:35.861] Timer tick, asking Buildbucket for the build status
[02:26:36.068] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:36.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:7:0) after 1m0s
[02:27:36.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:7:0)
[02:27:36.254] Timer tick, asking Buildbucket for the build status
[02:27:36.512] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:36.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:8:0) after 1m0s
[02:28:36.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:8:0)
[02:28:36.559] Timer tick, asking Buildbucket for the build status
[02:28:36.631] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:36.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:9:0) after 1m0s
[02:29:36.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:9:0)
[02:29:36.652] Timer tick, asking Buildbucket for the build status
[02:29:36.714] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:36.714] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:10:0) after 1m0s
[02:30:36.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:10:0)
[02:30:36.814] Timer tick, asking Buildbucket for the build status
[02:30:37.000] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:37.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:11:0) after 1m0s
[02:31:37.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:11:0)
[02:31:37.033] Timer tick, asking Buildbucket for the build status
[02:31:38.743] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:38.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:12:0) after 1m0s
[02:32:38.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:12:0)
[02:32:38.833] Timer tick, asking Buildbucket for the build status
[02:32:39.103] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:39.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:13:0) after 1m0s
[02:33:39.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:13:0)
[02:33:39.212] Timer tick, asking Buildbucket for the build status
[02:33:39.635] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:39.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:14:0) after 1m0s
[02:34:39.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:14:0)
[02:34:39.782] Timer tick, asking Buildbucket for the build status
[02:34:39.849] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:39.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:15:0) after 1m0s
[02:35:39.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:15:0)
[02:35:39.963] Timer tick, asking Buildbucket for the build status
[02:35:40.305] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:40.305] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:16:0) after 1m0s
[02:36:40.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:16:0)
[02:36:40.381] Timer tick, asking Buildbucket for the build status
[02:36:40.515] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:40.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:17:0) after 1m0s
[02:37:40.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:17:0)
[02:37:40.545] Timer tick, asking Buildbucket for the build status
[02:37:40.648] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:40.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:18:0) after 1m0s
[02:38:40.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:18:0)
[02:38:40.660] Timer tick, asking Buildbucket for the build status
[02:38:40.733] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:40.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:19:0) after 1m0s
[02:39:40.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:19:0)
[02:39:40.755] Timer tick, asking Buildbucket for the build status
[02:39:40.813] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:40.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:20:0) after 1m0s
[02:40:40.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:20:0)
[02:40:40.880] Timer tick, asking Buildbucket for the build status
[02:40:41.350] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:41.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:21:0) after 1m0s
[02:41:41.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:21:0)
[02:41:41.412] Timer tick, asking Buildbucket for the build status
[02:41:41.497] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:41.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:22:0) after 1m0s
[02:42:41.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:22:0)
[02:42:41.584] Timer tick, asking Buildbucket for the build status
[02:42:41.780] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:41.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:23:0) after 1m0s
[02:43:41.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:23:0)
[02:43:41.846] Timer tick, asking Buildbucket for the build status
[02:43:42.120] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:42.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:24:0) after 1m0s
[02:44:42.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:24:0)
[02:44:42.161] Timer tick, asking Buildbucket for the build status
[02:44:42.235] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:42.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:25:0) after 1m0s
[02:45:42.260] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:25:0)
[02:45:42.260] Timer tick, asking Buildbucket for the build status
[02:45:42.470] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:42.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:26:0) after 1m0s
[02:46:42.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:26:0)
[02:46:42.513] Timer tick, asking Buildbucket for the build status
[02:46:42.691] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:42.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:27:0) after 1m0s
[02:47:42.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:27:0)
[02:47:42.837] Timer tick, asking Buildbucket for the build status
[02:47:43.012] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:43.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:28:0) after 1m0s
[02:48:43.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:28:0)
[02:48:43.055] Timer tick, asking Buildbucket for the build status
[02:48:43.131] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:43.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:29:0) after 1m0s
[02:49:43.207] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:29:0)
[02:49:43.207] Timer tick, asking Buildbucket for the build status
[02:49:43.297] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:43.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:30:0) after 1m0s
[02:50:43.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:30:0)
[02:50:43.346] Timer tick, asking Buildbucket for the build status
[02:50:43.461] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:43.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:31:0) after 1m0s
[02:51:43.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:31:0)
[02:51:43.642] Timer tick, asking Buildbucket for the build status
[02:51:43.906] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:43.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:32:0) after 1m0s
[02:52:45.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:32:0)
[02:52:45.117] Timer tick, asking Buildbucket for the build status
[02:52:45.282] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:45.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:33:0) after 1m0s
[02:53:45.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:33:0)
[02:53:45.515] Timer tick, asking Buildbucket for the build status
[02:53:45.578] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:45.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:34:0) after 1m0s
[02:54:45.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:34:0)
[02:54:45.737] Timer tick, asking Buildbucket for the build status
[02:54:45.817] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:45.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:35:0) after 1m0s
[02:55:46.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:35:0)
[02:55:46.063] Timer tick, asking Buildbucket for the build status
[02:55:46.169] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:46.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:36:0) after 1m0s
[02:56:46.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:36:0)
[02:56:46.246] Timer tick, asking Buildbucket for the build status
[02:56:46.318] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:46.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:37:0) after 1m0s
[02:57:46.504] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:37:0)
[02:57:46.504] Timer tick, asking Buildbucket for the build status
[02:57:46.610] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:46.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:38:0) after 1m0s
[02:58:46.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:38:0)
[02:58:46.702] Timer tick, asking Buildbucket for the build status
[02:58:46.941] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:46.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:39:0) after 1m0s
[02:59:47.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:39:0)
[02:59:47.179] Timer tick, asking Buildbucket for the build status
[02:59:47.275] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:47.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:40:0) after 1m0s
[03:00:47.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:40:0)
[03:00:47.345] Timer tick, asking Buildbucket for the build status
[03:00:47.423] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:47.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:41:0) after 1m0s
[03:01:47.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:41:0)
[03:01:47.478] Timer tick, asking Buildbucket for the build status
[03:01:47.585] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:47.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:42:0) after 1m0s
[03:02:47.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:42:0)
[03:02:47.780] Timer tick, asking Buildbucket for the build status
[03:02:48.201] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:48.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:43:0) after 1m0s
[03:03:48.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:43:0)
[03:03:48.554] Timer tick, asking Buildbucket for the build status
[03:03:48.667] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:48.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:44:0) after 1m0s
[03:04:48.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:44:0)
[03:04:48.922] Timer tick, asking Buildbucket for the build status
[03:04:49.004] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:49.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:45:0) after 1m0s
[03:05:49.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:45:0)
[03:05:49.137] Timer tick, asking Buildbucket for the build status
[03:05:49.276] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:49.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:46:0) after 1m0s
[03:06:49.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:46:0)
[03:06:49.316] Timer tick, asking Buildbucket for the build status
[03:06:49.430] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:49.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:47:0) after 1m0s
[03:07:49.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:47:0)
[03:07:49.515] Timer tick, asking Buildbucket for the build status
[03:07:49.661] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:49.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:48:0) after 1m0s
[03:08:49.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:48:0)
[03:08:49.757] Timer tick, asking Buildbucket for the build status
[03:08:51.492] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:51.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:49:0) after 1m0s
[03:09:51.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:49:0)
[03:09:51.705] Timer tick, asking Buildbucket for the build status
[03:09:52.112] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:52.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:50:0) after 1m0s
[03:10:52.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:50:0)
[03:10:52.247] Timer tick, asking Buildbucket for the build status
[03:10:52.673] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:52.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:51:0) after 1m0s
[03:11:52.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:51:0)
[03:11:52.809] Timer tick, asking Buildbucket for the build status
[03:11:52.892] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:52.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:52:0) after 1m0s
[03:12:52.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:52:0)
[03:12:52.996] Timer tick, asking Buildbucket for the build status
[03:12:53.131] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:53.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:53:0) after 1m0s
[03:13:53.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:53:0)
[03:13:53.173] Timer tick, asking Buildbucket for the build status
[03:13:53.298] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:53.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:54:0) after 1m0s
[03:14:53.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:54:0)
[03:14:53.367] Timer tick, asking Buildbucket for the build status
[03:14:53.469] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:53.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:55:0) after 1m0s
[03:15:53.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:55:0)
[03:15:53.492] Timer tick, asking Buildbucket for the build status
[03:15:53.552] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:53.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:56:0) after 1m0s
[03:16:53.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:56:0)
[03:16:53.671] Timer tick, asking Buildbucket for the build status
[03:16:53.747] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:53.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:57:0) after 1m0s
[03:17:54.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:57:0)
[03:17:54.543] Timer tick, asking Buildbucket for the build status
[03:17:54.688] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:54.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:58:0) after 1m0s
[03:18:54.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:58:0)
[03:18:54.708] Timer tick, asking Buildbucket for the build status
[03:18:54.772] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:54.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:59:0) after 1m0s
[03:19:55.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:59:0)
[03:19:55.159] Timer tick, asking Buildbucket for the build status
[03:19:55.220] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:55.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:60:0) after 1m0s
[03:20:55.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:60:0)
[03:20:55.425] Timer tick, asking Buildbucket for the build status
[03:20:55.601] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:55.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:61:0) after 1m0s
[03:21:55.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:61:0)
[03:21:55.723] Timer tick, asking Buildbucket for the build status
[03:21:55.785] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:55.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:62:0) after 1m0s
[03:22:56.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:62:0)
[03:22:56.125] Timer tick, asking Buildbucket for the build status
[03:22:56.241] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:56.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:63:0) after 1m0s
[03:23:56.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:63:0)
[03:23:56.514] Timer tick, asking Buildbucket for the build status
[03:23:56.587] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:56.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:64:0) after 1m0s
[03:24:56.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:64:0)
[03:24:56.681] Timer tick, asking Buildbucket for the build status
[03:24:56.797] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:56.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:65:0) after 1m0s
[03:25:56.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:65:0)
[03:25:56.906] Timer tick, asking Buildbucket for the build status
[03:25:56.998] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:56.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:66:0) after 1m0s
[03:26:57.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:66:0)
[03:26:57.853] Timer tick, asking Buildbucket for the build status
[03:26:57.923] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:57.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:67:0) after 1m0s
[03:27:58.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:67:0)
[03:27:58.096] Timer tick, asking Buildbucket for the build status
[03:27:58.221] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:58.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:68:0) after 1m0s
[03:28:58.269] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:68:0)
[03:28:58.269] Timer tick, asking Buildbucket for the build status
[03:28:58.342] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:58.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:69:0) after 1m0s
[03:29:58.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:69:0)
[03:29:58.824] Timer tick, asking Buildbucket for the build status
[03:29:58.884] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:58.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:70:0) after 1m0s
[03:30:59.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:70:0)
[03:30:59.104] Timer tick, asking Buildbucket for the build status
[03:30:59.225] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:59.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:71:0) after 1m0s
[03:31:59.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:71:0)
[03:31:59.236] Timer tick, asking Buildbucket for the build status
[03:31:59.330] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:59.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:72:0) after 1m0s
[03:32:59.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:72:0)
[03:32:59.387] Timer tick, asking Buildbucket for the build status
[03:32:59.550] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:59.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:73:0) after 1m0s
[03:33:59.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:73:0)
[03:33:59.625] Timer tick, asking Buildbucket for the build status
[03:33:59.702] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:59.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:74:0) after 1m0s
[03:34:59.799] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:74:0)
[03:34:59.799] Timer tick, asking Buildbucket for the build status
[03:35:00.132] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:00.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:75:0) after 1m0s
[03:36:00.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:75:0)
[03:36:00.301] Timer tick, asking Buildbucket for the build status
[03:36:00.753] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:00.753] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:76:0) after 1m0s
[03:37:00.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:76:0)
[03:37:00.937] Timer tick, asking Buildbucket for the build status
[03:37:02.898] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:02.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:77:0) after 1m0s
[03:38:03.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:77:0)
[03:38:03.087] Timer tick, asking Buildbucket for the build status
[03:38:03.342] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:03.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:78:0) after 1m0s
[03:39:03.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:78:0)
[03:39:03.397] Timer tick, asking Buildbucket for the build status
[03:39:03.536] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:03.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:79:0) after 1m0s
[03:40:03.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:79:0)
[03:40:03.629] Timer tick, asking Buildbucket for the build status
[03:40:04.105] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:04.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:80:0) after 1m0s
[03:41:04.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:80:0)
[03:41:04.197] Timer tick, asking Buildbucket for the build status
[03:41:04.268] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:04.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:81:0) after 1m0s
[03:42:04.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:81:0)
[03:42:04.293] Timer tick, asking Buildbucket for the build status
[03:42:06.126] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:06.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:82:0) after 1m0s
[03:43:06.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:82:0)
[03:43:06.155] Timer tick, asking Buildbucket for the build status
[03:43:06.263] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:06.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:83:0) after 1m0s
[03:44:06.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:83:0)
[03:44:06.343] Timer tick, asking Buildbucket for the build status
[03:44:06.671] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:06.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:84:0) after 1m0s
[03:45:06.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:84:0)
[03:45:06.693] Timer tick, asking Buildbucket for the build status
[03:45:06.785] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:06.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:85:0) after 1m0s
[03:46:06.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:85:0)
[03:46:06.891] Timer tick, asking Buildbucket for the build status
[03:46:07.045] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:07.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:86:0) after 1m0s
[03:47:07.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:86:0)
[03:47:07.131] Timer tick, asking Buildbucket for the build status
[03:47:07.185] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:07.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:87:0) after 1m0s
[03:48:07.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:87:0)
[03:48:07.234] Timer tick, asking Buildbucket for the build status
[03:48:07.821] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:07.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:88:0) after 1m0s
[03:49:07.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:88:0)
[03:49:07.850] Timer tick, asking Buildbucket for the build status
[03:49:08.022] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:08.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:89:0) after 1m0s
[03:50:08.081] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:89:0)
[03:50:08.081] Timer tick, asking Buildbucket for the build status
[03:50:08.171] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:08.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:90:0) after 1m0s
[03:51:08.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:90:0)
[03:51:08.201] Timer tick, asking Buildbucket for the build status
[03:51:08.588] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:08.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:91:0) after 1m0s
[03:52:08.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:91:0)
[03:52:08.637] Timer tick, asking Buildbucket for the build status
[03:52:08.766] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:08.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:92:0) after 1m0s
[03:53:08.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:92:0)
[03:53:08.791] Timer tick, asking Buildbucket for the build status
[03:53:09.219] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:09.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:93:0) after 1m0s
[03:54:09.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:93:0)
[03:54:09.244] Timer tick, asking Buildbucket for the build status
[03:54:09.322] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:09.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:94:0) after 1m0s
[03:55:09.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:94:0)
[03:55:09.394] Timer tick, asking Buildbucket for the build status
[03:55:09.483] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:09.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:95:0) after 1m0s
[03:56:09.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:95:0)
[03:56:09.558] Timer tick, asking Buildbucket for the build status
[03:56:09.644] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:09.644] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:96:0) after 1m0s
[03:57:09.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:96:0)
[03:57:09.731] Timer tick, asking Buildbucket for the build status
[03:57:09.801] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:09.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:97:0) after 1m0s
[03:58:09.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:97:0)
[03:58:09.849] Timer tick, asking Buildbucket for the build status
[03:58:10.224] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:10.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:98:0) after 1m0s
[03:59:10.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:98:0)
[03:59:10.291] Timer tick, asking Buildbucket for the build status
[03:59:10.367] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:10.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:99:0) after 1m0s
[04:00:10.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:99:0)
[04:00:10.507] Timer tick, asking Buildbucket for the build status
[04:00:11.481] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:11.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:100:0) after 1m0s
[04:01:12.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:100:0)
[04:01:12.159] Timer tick, asking Buildbucket for the build status
[04:01:12.299] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:12.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:101:0) after 1m0s
[04:02:12.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:101:0)
[04:02:12.408] Timer tick, asking Buildbucket for the build status
[04:02:12.875] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:12.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:102:0) after 1m0s
[04:03:12.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:102:0)
[04:03:12.984] Timer tick, asking Buildbucket for the build status
[04:03:13.124] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:13.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:103:0) after 1m0s
[04:04:13.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:103:0)
[04:04:13.226] Timer tick, asking Buildbucket for the build status
[04:04:13.309] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:13.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:104:0) after 1m0s
[04:05:13.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:104:0)
[04:05:13.469] Timer tick, asking Buildbucket for the build status
[04:05:13.579] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:13.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:105:0) after 1m0s
[04:06:13.598] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:105:0)
[04:06:13.598] Timer tick, asking Buildbucket for the build status
[04:06:13.651] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:13.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:106:0) after 1m0s
[04:07:13.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:106:0)
[04:07:13.676] Timer tick, asking Buildbucket for the build status
[04:07:13.765] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:13.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:107:0) after 1m0s
[04:08:13.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:107:0)
[04:08:13.833] Timer tick, asking Buildbucket for the build status
[04:08:14.069] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:14.069] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:108:0) after 1m0s
[04:09:14.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:108:0)
[04:09:14.093] Timer tick, asking Buildbucket for the build status
[04:09:14.515] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:14.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:109:0) after 1m0s
[04:10:14.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:109:0)
[04:10:14.544] Timer tick, asking Buildbucket for the build status
[04:10:14.684] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:14.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:110:0) after 1m0s
[04:11:14.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:110:0)
[04:11:14.747] Timer tick, asking Buildbucket for the build status
[04:11:14.835] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:14.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:111:0) after 1m0s
[04:12:14.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:111:0)
[04:12:14.860] Timer tick, asking Buildbucket for the build status
[04:12:14.929] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:14.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:112:0) after 1m0s
[04:13:15.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:112:0)
[04:13:15.412] Timer tick, asking Buildbucket for the build status
[04:13:15.536] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:15.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:113:0) after 1m0s
[04:14:15.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:113:0)
[04:14:15.699] Timer tick, asking Buildbucket for the build status
[04:14:15.777] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:15.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:114:0) after 1m0s
[04:15:15.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:114:0)
[04:15:15.762] Timer tick, asking Buildbucket for the build status
[04:15:15.819] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:15.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:115:0) after 1m0s
[04:16:15.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:115:0)
[04:16:15.893] Timer tick, asking Buildbucket for the build status
[04:16:15.986] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:15.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:116:0) after 1m0s
[04:17:16.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:116:0)
[04:17:16.555] Timer tick, asking Buildbucket for the build status
[04:17:16.691] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:16.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:117:0) after 1m0s
[04:18:17.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:117:0)
[04:18:17.023] Timer tick, asking Buildbucket for the build status
[04:18:17.362] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:17.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:118:0) after 1m0s
[04:19:17.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:118:0)
[04:19:17.609] Timer tick, asking Buildbucket for the build status
[04:19:17.684] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:17.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:119:0) after 1m0s
[04:20:17.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:119:0)
[04:20:17.843] Timer tick, asking Buildbucket for the build status
[04:20:17.912] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:17.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:120:0) after 1m0s
[04:21:18.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:120:0)
[04:21:18.029] Timer tick, asking Buildbucket for the build status
[04:21:18.391] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:18.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:121:0) after 1m0s
[04:22:18.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:121:0)
[04:22:18.594] Timer tick, asking Buildbucket for the build status
[04:22:18.723] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:18.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:122:0) after 1m0s
[04:23:19.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:122:0)
[04:23:19.459] Timer tick, asking Buildbucket for the build status
[04:23:19.556] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:19.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:123:0) after 1m0s
[04:24:19.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:123:0)
[04:24:19.695] Timer tick, asking Buildbucket for the build status
[04:24:19.984] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:19.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:124:0) after 1m0s
[04:25:20.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:124:0)
[04:25:20.256] Timer tick, asking Buildbucket for the build status
[04:25:20.343] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:20.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:125:0) after 1m0s
[04:26:20.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:125:0)
[04:26:20.493] Timer tick, asking Buildbucket for the build status
[04:26:20.584] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:20.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:126:0) after 1m0s
[04:27:20.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:126:0)
[04:27:20.837] Timer tick, asking Buildbucket for the build status
[04:27:20.943] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:20.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:127:0) after 1m0s
[04:28:21.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:127:0)
[04:28:21.327] Timer tick, asking Buildbucket for the build status
[04:28:21.587] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:21.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:128:0) after 1m0s
[04:29:21.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:128:0)
[04:29:21.701] Timer tick, asking Buildbucket for the build status
[04:29:21.759] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:21.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:129:0) after 1m0s
[04:30:21.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:129:0)
[04:30:21.840] Timer tick, asking Buildbucket for the build status
[04:30:21.910] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:21.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:130:0) after 1m0s
[04:31:22.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:130:0)
[04:31:22.047] Timer tick, asking Buildbucket for the build status
[04:31:22.138] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:22.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:131:0) after 1m0s
[04:32:22.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:131:0)
[04:32:22.227] Timer tick, asking Buildbucket for the build status
[04:32:22.551] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:22.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:132:0) after 1m0s
[04:33:22.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:132:0)
[04:33:22.619] Timer tick, asking Buildbucket for the build status
[04:33:23.004] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:23.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:133:0) after 1m0s
[04:34:23.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:133:0)
[04:34:23.218] Timer tick, asking Buildbucket for the build status
[04:34:26.156] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:26.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:134:0) after 1m0s
[04:35:26.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:134:0)
[04:35:26.461] Timer tick, asking Buildbucket for the build status
[04:35:26.734] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:26.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:135:0) after 1m0s
[04:36:26.826] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:135:0)
[04:36:26.826] Timer tick, asking Buildbucket for the build status
[04:36:26.973] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:26.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:136:0) after 1m0s
[04:37:27.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:136:0)
[04:37:27.101] Timer tick, asking Buildbucket for the build status
[04:37:27.174] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:27.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:137:0) after 1m0s
[04:38:27.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:137:0)
[04:38:27.341] Timer tick, asking Buildbucket for the build status
[04:38:27.477] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:27.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:138:0) after 1m0s
[04:39:27.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:138:0)
[04:39:27.578] Timer tick, asking Buildbucket for the build status
[04:39:27.663] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:27.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:139:0) after 1m0s
[04:40:27.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:139:0)
[04:40:27.780] Timer tick, asking Buildbucket for the build status
[04:40:30.407] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:30.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:140:0) after 1m0s
[04:41:30.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:140:0)
[04:41:30.805] Timer tick, asking Buildbucket for the build status
[04:41:30.866] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:30.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:141:0) after 1m0s
[04:42:31.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:141:0)
[04:42:31.104] Timer tick, asking Buildbucket for the build status
[04:42:31.205] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:31.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:142:0) after 1m0s
[04:43:31.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:142:0)
[04:43:31.240] Timer tick, asking Buildbucket for the build status
[04:43:31.407] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:31.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:143:0) after 1m0s
[04:44:31.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:143:0)
[04:44:31.494] Timer tick, asking Buildbucket for the build status
[04:44:31.578] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:31.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:144:0) after 1m0s
[04:45:31.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:144:0)
[04:45:31.642] Timer tick, asking Buildbucket for the build status
[04:45:31.704] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:31.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:145:0) after 1m0s
[04:46:31.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:145:0)
[04:46:31.831] Timer tick, asking Buildbucket for the build status
[04:46:31.897] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:31.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:146:0) after 1m0s
[04:47:31.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:146:0)
[04:47:31.982] Timer tick, asking Buildbucket for the build status
[04:47:32.065] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:32.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:147:0) after 1m0s
[04:48:32.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:147:0)
[04:48:32.132] Timer tick, asking Buildbucket for the build status
[04:48:32.298] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:32.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:148:0) after 1m0s
[04:49:32.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:148:0)
[04:49:32.395] Timer tick, asking Buildbucket for the build status
[04:49:32.589] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:32.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:149:0) after 1m0s
[04:50:32.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:149:0)
[04:50:32.690] Timer tick, asking Buildbucket for the build status
[04:50:32.771] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:32.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:150:0) after 1m0s
[04:51:32.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:150:0)
[04:51:32.836] Timer tick, asking Buildbucket for the build status
[04:51:33.081] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:33.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:151:0) after 1m0s
[04:52:33.130] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:151:0)
[04:52:33.130] Timer tick, asking Buildbucket for the build status
[04:52:33.571] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:33.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:152:0) after 1m0s
[04:53:33.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:152:0)
[04:53:33.594] Timer tick, asking Buildbucket for the build status
[04:53:33.710] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:33.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:153:0) after 1m0s
[04:54:33.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:153:0)
[04:54:33.740] Timer tick, asking Buildbucket for the build status
[04:54:33.816] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:33.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:154:0) after 1m0s
[04:55:33.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:154:0)
[04:55:33.867] Timer tick, asking Buildbucket for the build status
[04:55:34.068] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:34.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:155:0) after 1m0s
[04:56:34.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:155:0)
[04:56:34.126] Timer tick, asking Buildbucket for the build status
[04:56:34.246] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:34.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:156:0) after 1m0s
[04:57:34.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:156:0)
[04:57:34.287] Timer tick, asking Buildbucket for the build status
[04:57:34.572] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:34.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:157:0) after 1m0s
[04:58:34.630] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:157:0)
[04:58:34.630] Timer tick, asking Buildbucket for the build status
[04:58:34.933] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:34.933] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:158:0) after 1m0s
[04:59:34.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:158:0)
[04:59:34.982] Timer tick, asking Buildbucket for the build status
[04:59:35.086] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:35.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:159:0) after 1m0s
[05:00:35.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:159:0)
[05:00:35.154] Timer tick, asking Buildbucket for the build status
[05:00:35.227] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:35.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:160:0) after 1m0s
[05:01:35.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:160:0)
[05:01:35.272] Timer tick, asking Buildbucket for the build status
[05:01:35.362] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:35.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:161:0) after 1m0s
[05:02:35.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:161:0)
[05:02:35.373] Timer tick, asking Buildbucket for the build status
[05:02:35.582] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:35.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:162:0) after 1m0s
[05:03:35.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:162:0)
[05:03:35.641] Timer tick, asking Buildbucket for the build status
[05:03:35.737] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:35.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:163:0) after 1m0s
[05:04:35.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:163:0)
[05:04:35.797] Timer tick, asking Buildbucket for the build status
[05:04:36.007] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:36.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:164:0) after 1m0s
[05:05:36.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:164:0)
[05:05:36.060] Timer tick, asking Buildbucket for the build status
[05:05:36.357] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:36.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:165:0) after 1m0s
[05:06:36.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:165:0)
[05:06:36.415] Timer tick, asking Buildbucket for the build status
[05:06:36.578] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:36.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:166:0) after 1m0s
[05:07:36.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:166:0)
[05:07:36.616] Timer tick, asking Buildbucket for the build status
[05:07:36.690] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:36.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:167:0) after 1m0s
[05:08:36.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:167:0)
[05:08:36.727] Timer tick, asking Buildbucket for the build status
[05:08:37.630] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:37.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:168:0) after 1m0s
[05:09:37.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:168:0)
[05:09:37.669] Timer tick, asking Buildbucket for the build status
[05:09:37.733] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:37.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:169:0) after 1m0s
[05:10:37.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:169:0)
[05:10:37.776] Timer tick, asking Buildbucket for the build status
[05:10:37.859] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:37.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:170:0) after 1m0s
[05:11:37.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:170:0)
[05:11:37.915] Timer tick, asking Buildbucket for the build status
[05:11:37.991] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:37.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:171:0) after 1m0s
[05:12:38.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:171:0)
[05:12:38.141] Timer tick, asking Buildbucket for the build status
[05:12:38.232] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:38.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:172:0) after 1m0s
[05:13:38.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:172:0)
[05:13:38.321] Timer tick, asking Buildbucket for the build status
[05:13:38.847] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:38.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:173:0) after 1m0s
[05:14:38.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:173:0)
[05:14:38.940] Timer tick, asking Buildbucket for the build status
[05:14:39.023] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:39.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:174:0) after 1m0s
[05:15:39.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:174:0)
[05:15:39.055] Timer tick, asking Buildbucket for the build status
[05:15:39.133] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:39.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:175:0) after 1m0s
[05:16:39.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:175:0)
[05:16:39.221] Timer tick, asking Buildbucket for the build status
[05:16:39.438] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:39.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:176:0) after 1m0s
[05:17:39.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:176:0)
[05:17:39.467] Timer tick, asking Buildbucket for the build status
[05:17:39.794] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:39.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:177:0) after 1m0s
[05:18:39.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:177:0)
[05:18:39.832] Timer tick, asking Buildbucket for the build status
[05:18:40.413] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:40.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:178:0) after 1m0s
[05:19:40.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:178:0)
[05:19:40.472] Timer tick, asking Buildbucket for the build status
[05:19:40.568] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:40.568] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:179:0) after 1m0s
[05:20:40.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:179:0)
[05:20:40.606] Timer tick, asking Buildbucket for the build status
[05:20:40.823] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:40.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:180:0) after 1m0s
[05:21:40.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:180:0)
[05:21:40.823] Timer tick, asking Buildbucket for the build status
[05:21:40.898] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:40.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:181:0) after 1m0s
[05:22:40.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:181:0)
[05:22:40.975] Timer tick, asking Buildbucket for the build status
[05:22:41.058] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:41.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:182:0) after 1m0s
[05:23:41.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:182:0)
[05:23:41.122] Timer tick, asking Buildbucket for the build status
[05:23:41.289] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:41.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:183:0) after 1m0s
[05:24:41.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:183:0)
[05:24:41.350] Timer tick, asking Buildbucket for the build status
[05:24:41.542] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:41.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:184:0) after 1m0s
[05:25:41.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:184:0)
[05:25:41.570] Timer tick, asking Buildbucket for the build status
[05:25:41.823] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:41.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:185:0) after 1m0s
[05:26:41.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:185:0)
[05:26:41.989] Timer tick, asking Buildbucket for the build status
[05:26:42.109] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:42.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:186:0) after 1m0s
[05:27:42.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:186:0)
[05:27:42.173] Timer tick, asking Buildbucket for the build status
[05:27:42.264] Build 8869128928047359200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:42.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9034558990219756064:187:0) after 1m0s
[05:28:30.946] Received PubSub notification, asking Buildbucket for the build status
[05:28:31.115] Build 8869128928047359200: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:28:31.115] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1600147710050497",
    "created_by": "project:infra",
    "created_ts": "1600136554633198",
    "id": "8869128928047359200",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4263.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"d1bf57c4-ced8-4351-a806-0791a5715418\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4263.3\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-b2yr\"], \"image\": [\"chrome-xenial-20091300-9b3346fad90\"], \"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\": [\"5522-67570db\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1600136614777475",
    "status": "COMPLETED",
    "status_changed_ts": "1600147710541790",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9034558990219756064",
      "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/8869128928047359200/+/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:4ea863b2ea45b110",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1600147710555011",
    "url": "https://ci.chromium.org/b/8869128928047359200",
    "utcnow_ts": "1600147711098017"
  }
}
[05:28:31.115] Invocation finished in 3h5m57.936349778s with status SUCCEEDED