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

• parent_buildername:publish_tarball
• user_agent:recipe

[07:41:26.086] New invocation is queued and will start shortly
[07:41:26.086] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[07:41:27.174] Starting the invocation (attempt 1)
[07:41:27.224] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:41:27.224] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:41:27.224] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9035716688493182128",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"87.0.4252.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"b0f0b8d7-4cea-4b03-bfaf-95e385ecc90b\",\"title\":\"publish_tarball/0\"}]},\"version\":\"87.0.4252.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:9035716688493182128",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[07:41:29.178] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1599032488509255",
    "id": "8870286625287139520",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4252.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"b0f0b8d7-4cea-4b03-bfaf-95e385ecc90b\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4252.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1599032488879104",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9035716688493182128",
      "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/8870286625287139520/+/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": "1599032488879277",
    "url": "https://ci.chromium.org/b/8870286625287139520",
    "utcnow_ts": "1599032489169339"
  }
}
[07:41:29.178] Task URL: https://ci.chromium.org/b/8870286625287139520
[07:41:29.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:2:0) after 1m0s
[07:41:33.216] Received PubSub notification, asking Buildbucket for the build status
[07:41:33.295] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:29.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:2:0)
[07:42:29.203] Timer tick, asking Buildbucket for the build status
[07:42:29.325] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:29.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:4:0) after 1m0s
[07:43:29.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:4:0)
[07:43:29.390] Timer tick, asking Buildbucket for the build status
[07:43:30.492] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:30.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:5:0) after 1m0s
[07:44:30.501] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:5:0)
[07:44:30.501] Timer tick, asking Buildbucket for the build status
[07:44:30.571] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:30.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:6:0) after 1m0s
[07:45:30.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:6:0)
[07:45:30.611] Timer tick, asking Buildbucket for the build status
[07:45:30.693] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:30.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:7:0) after 1m0s
[07:46:30.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:7:0)
[07:46:30.735] Timer tick, asking Buildbucket for the build status
[07:46:31.627] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:31.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:8:0) after 1m0s
[07:47:31.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:8:0)
[07:47:31.882] Timer tick, asking Buildbucket for the build status
[07:47:32.028] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:32.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:9:0) after 1m0s
[07:48:32.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:9:0)
[07:48:32.044] Timer tick, asking Buildbucket for the build status
[07:48:32.424] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:32.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:10:0) after 1m0s
[07:49:32.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:10:0)
[07:49:32.444] Timer tick, asking Buildbucket for the build status
[07:49:32.615] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:32.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:11:0) after 1m0s
[07:50:32.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:11:0)
[07:50:32.796] Timer tick, asking Buildbucket for the build status
[07:50:33.007] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:33.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:12:0) after 1m0s
[07:51:33.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:12:0)
[07:51:33.342] Timer tick, asking Buildbucket for the build status
[07:51:33.545] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:33.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:13:0) after 1m0s
[07:52:33.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:13:0)
[07:52:33.893] Timer tick, asking Buildbucket for the build status
[07:52:34.007] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:34.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:14:0) after 1m0s
[07:53:34.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:14:0)
[07:53:34.053] Timer tick, asking Buildbucket for the build status
[07:53:34.327] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:34.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:15:0) after 1m0s
[07:54:34.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:15:0)
[07:54:34.593] Timer tick, asking Buildbucket for the build status
[07:54:34.762] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:34.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:16:0) after 1m0s
[07:55:34.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:16:0)
[07:55:34.848] Timer tick, asking Buildbucket for the build status
[07:55:34.930] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:34.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:17:0) after 1m0s
[07:56:34.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:17:0)
[07:56:34.970] Timer tick, asking Buildbucket for the build status
[07:56:35.155] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:35.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:18:0) after 1m0s
[07:57:35.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:18:0)
[07:57:35.258] Timer tick, asking Buildbucket for the build status
[07:57:35.423] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:35.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:19:0) after 1m0s
[07:58:35.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:19:0)
[07:58:35.439] Timer tick, asking Buildbucket for the build status
[07:58:35.619] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:35.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:20:0) after 1m0s
[07:59:35.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:20:0)
[07:59:35.696] Timer tick, asking Buildbucket for the build status
[07:59:35.783] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:35.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:21:0) after 1m0s
[08:00:35.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:21:0)
[08:00:35.846] Timer tick, asking Buildbucket for the build status
[08:00:35.922] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:35.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:22:0) after 1m0s
[08:01:35.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:22:0)
[08:01:35.975] Timer tick, asking Buildbucket for the build status
[08:01:36.215] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:36.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:23:0) after 1m0s
[08:02:36.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:23:0)
[08:02:36.284] Timer tick, asking Buildbucket for the build status
[08:02:36.578] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:36.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:24:0) after 1m0s
[08:03:36.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:24:0)
[08:03:36.705] Timer tick, asking Buildbucket for the build status
[08:03:37.234] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:37.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:25:0) after 1m0s
[08:04:37.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:25:0)
[08:04:37.255] Timer tick, asking Buildbucket for the build status
[08:04:37.362] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:37.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:26:0) after 1m0s
[08:05:37.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:26:0)
[08:05:37.506] Timer tick, asking Buildbucket for the build status
[08:05:37.600] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:37.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:27:0) after 1m0s
[08:06:37.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:27:0)
[08:06:37.808] Timer tick, asking Buildbucket for the build status
[08:06:38.026] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:38.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:28:0) after 1m0s
[08:07:38.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:28:0)
[08:07:38.372] Timer tick, asking Buildbucket for the build status
[08:07:38.614] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:38.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:29:0) after 1m0s
[08:08:38.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:29:0)
[08:08:38.671] Timer tick, asking Buildbucket for the build status
[08:08:38.810] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:38.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:30:0) after 1m0s
[08:09:38.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:30:0)
[08:09:38.946] Timer tick, asking Buildbucket for the build status
[08:09:39.008] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:39.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:31:0) after 1m0s
[08:10:39.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:31:0)
[08:10:39.095] Timer tick, asking Buildbucket for the build status
[08:10:39.163] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:39.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:32:0) after 1m0s
[08:11:39.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:32:0)
[08:11:39.350] Timer tick, asking Buildbucket for the build status
[08:11:39.503] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:39.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:33:0) after 1m0s
[08:12:39.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:33:0)
[08:12:39.539] Timer tick, asking Buildbucket for the build status
[08:12:39.622] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:39.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:34:0) after 1m0s
[08:13:39.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:34:0)
[08:13:39.904] Timer tick, asking Buildbucket for the build status
[08:13:40.164] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:40.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:35:0) after 1m0s
[08:14:40.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:35:0)
[08:14:40.366] Timer tick, asking Buildbucket for the build status
[08:14:40.588] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:40.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:36:0) after 1m0s
[08:15:40.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:36:0)
[08:15:40.691] Timer tick, asking Buildbucket for the build status
[08:15:40.774] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:40.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:37:0) after 1m0s
[08:16:40.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:37:0)
[08:16:40.918] Timer tick, asking Buildbucket for the build status
[08:16:41.075] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:41.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:38:0) after 1m0s
[08:17:41.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:38:0)
[08:17:41.352] Timer tick, asking Buildbucket for the build status
[08:17:41.739] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:41.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:39:0) after 1m0s
[08:18:41.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:39:0)
[08:18:41.790] Timer tick, asking Buildbucket for the build status
[08:18:41.876] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:41.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:40:0) after 1m0s
[08:19:41.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:40:0)
[08:19:41.905] Timer tick, asking Buildbucket for the build status
[08:19:41.976] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:41.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:41:0) after 1m0s
[08:20:42.010] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:41:0)
[08:20:42.010] Timer tick, asking Buildbucket for the build status
[08:20:42.184] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:42.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:42:0) after 1m0s
[08:21:42.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:42:0)
[08:21:42.271] Timer tick, asking Buildbucket for the build status
[08:21:42.446] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:42.446] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:43:0) after 1m0s
[08:22:42.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:43:0)
[08:22:42.565] Timer tick, asking Buildbucket for the build status
[08:22:42.766] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:42.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:44:0) after 1m0s
[08:23:42.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:44:0)
[08:23:42.807] Timer tick, asking Buildbucket for the build status
[08:23:43.037] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:43.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:45:0) after 1m0s
[08:24:43.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:45:0)
[08:24:43.087] Timer tick, asking Buildbucket for the build status
[08:24:43.197] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:43.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:46:0) after 1m0s
[08:25:43.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:46:0)
[08:25:43.213] Timer tick, asking Buildbucket for the build status
[08:25:43.586] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:43.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:47:0) after 1m0s
[08:26:43.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:47:0)
[08:26:43.614] Timer tick, asking Buildbucket for the build status
[08:26:43.731] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:43.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:48:0) after 1m0s
[08:27:43.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:48:0)
[08:27:43.795] Timer tick, asking Buildbucket for the build status
[08:27:43.851] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:43.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:49:0) after 1m0s
[08:28:43.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:49:0)
[08:28:43.904] Timer tick, asking Buildbucket for the build status
[08:28:44.021] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:44.021] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:50:0) after 1m0s
[08:29:44.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:50:0)
[08:29:44.103] Timer tick, asking Buildbucket for the build status
[08:29:44.166] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:44.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:51:0) after 1m0s
[08:30:44.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:51:0)
[08:30:44.204] Timer tick, asking Buildbucket for the build status
[08:30:44.311] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:44.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:52:0) after 1m0s
[08:31:44.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:52:0)
[08:31:44.527] Timer tick, asking Buildbucket for the build status
[08:31:44.704] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:44.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:53:0) after 1m0s
[08:32:44.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:53:0)
[08:32:44.776] Timer tick, asking Buildbucket for the build status
[08:32:45.173] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:45.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:54:0) after 1m0s
[08:33:45.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:54:0)
[08:33:45.490] Timer tick, asking Buildbucket for the build status
[08:33:48.321] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:48.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:55:0) after 1m0s
[08:34:48.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:55:0)
[08:34:48.344] Timer tick, asking Buildbucket for the build status
[08:34:48.445] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:48.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:56:0) after 1m0s
[08:35:48.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:56:0)
[08:35:48.625] Timer tick, asking Buildbucket for the build status
[08:35:48.698] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:48.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:57:0) after 1m0s
[08:36:48.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:57:0)
[08:36:48.830] Timer tick, asking Buildbucket for the build status
[08:36:49.434] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:49.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:58:0) after 1m0s
[08:37:49.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:58:0)
[08:37:49.490] Timer tick, asking Buildbucket for the build status
[08:37:49.568] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:49.568] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:59:0) after 1m0s
[08:38:49.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:59:0)
[08:38:49.670] Timer tick, asking Buildbucket for the build status
[08:38:50.463] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:50.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:60:0) after 1m0s
[08:39:50.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:60:0)
[08:39:50.634] Timer tick, asking Buildbucket for the build status
[08:39:50.724] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:50.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:61:0) after 1m0s
[08:40:50.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:61:0)
[08:40:50.870] Timer tick, asking Buildbucket for the build status
[08:40:50.934] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:50.934] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:62:0) after 1m0s
[08:41:50.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:62:0)
[08:41:50.979] Timer tick, asking Buildbucket for the build status
[08:41:51.170] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:51.170] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:63:0) after 1m0s
[08:42:51.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:63:0)
[08:42:51.195] Timer tick, asking Buildbucket for the build status
[08:42:51.283] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:51.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:64:0) after 1m0s
[08:43:51.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:64:0)
[08:43:51.302] Timer tick, asking Buildbucket for the build status
[08:43:51.381] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:51.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:65:0) after 1m0s
[08:44:51.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:65:0)
[08:44:51.357] Timer tick, asking Buildbucket for the build status
[08:44:51.645] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:51.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:66:0) after 1m0s
[08:45:51.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:66:0)
[08:45:51.756] Timer tick, asking Buildbucket for the build status
[08:45:51.953] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:51.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:67:0) after 1m0s
[08:46:52.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:67:0)
[08:46:52.014] Timer tick, asking Buildbucket for the build status
[08:46:52.489] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:52.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:68:0) after 1m0s
[08:47:52.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:68:0)
[08:47:52.811] Timer tick, asking Buildbucket for the build status
[08:47:53.021] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:53.021] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:69:0) after 1m0s
[08:48:53.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:69:0)
[08:48:53.076] Timer tick, asking Buildbucket for the build status
[08:48:53.401] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:53.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:70:0) after 1m0s
[08:49:53.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:70:0)
[08:49:53.496] Timer tick, asking Buildbucket for the build status
[08:49:53.567] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:53.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:71:0) after 1m0s
[08:50:53.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:71:0)
[08:50:53.633] Timer tick, asking Buildbucket for the build status
[08:50:53.701] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:53.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:72:0) after 1m0s
[08:51:54.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:72:0)
[08:51:54.206] Timer tick, asking Buildbucket for the build status
[08:51:54.783] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:54.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:73:0) after 1m0s
[08:52:55.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:73:0)
[08:52:55.045] Timer tick, asking Buildbucket for the build status
[08:52:55.152] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:55.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:74:0) after 1m0s
[08:53:55.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:74:0)
[08:53:55.414] Timer tick, asking Buildbucket for the build status
[08:53:55.530] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:55.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:75:0) after 1m0s
[08:54:55.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:75:0)
[08:54:55.795] Timer tick, asking Buildbucket for the build status
[08:54:55.902] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:55.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:76:0) after 1m0s
[08:55:55.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:76:0)
[08:55:55.942] Timer tick, asking Buildbucket for the build status
[08:55:56.012] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:56.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:77:0) after 1m0s
[08:56:56.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:77:0)
[08:56:56.245] Timer tick, asking Buildbucket for the build status
[08:56:56.346] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:56.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:78:0) after 1m0s
[08:57:56.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:78:0)
[08:57:56.463] Timer tick, asking Buildbucket for the build status
[08:57:56.596] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:56.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:79:0) after 1m0s
[08:58:56.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:79:0)
[08:58:56.760] Timer tick, asking Buildbucket for the build status
[08:58:56.861] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:56.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:80:0) after 1m0s
[08:59:57.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:80:0)
[08:59:57.369] Timer tick, asking Buildbucket for the build status
[08:59:57.608] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:57.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:81:0) after 1m0s
[09:00:57.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:81:0)
[09:00:57.746] Timer tick, asking Buildbucket for the build status
[09:00:57.837] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:57.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:82:0) after 1m0s
[09:01:57.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:82:0)
[09:01:57.916] Timer tick, asking Buildbucket for the build status
[09:01:58.355] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:58.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:83:0) after 1m0s
[09:02:58.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:83:0)
[09:02:58.465] Timer tick, asking Buildbucket for the build status
[09:02:58.613] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:58.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:84:0) after 1m0s
[09:03:58.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:84:0)
[09:03:58.764] Timer tick, asking Buildbucket for the build status
[09:03:58.898] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:58.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:85:0) after 1m0s
[09:04:59.090] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:85:0)
[09:04:59.090] Timer tick, asking Buildbucket for the build status
[09:04:59.179] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:59.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:86:0) after 1m0s
[09:05:59.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:86:0)
[09:05:59.359] Timer tick, asking Buildbucket for the build status
[09:05:59.438] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:59.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:87:0) after 1m0s
[09:06:59.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:87:0)
[09:06:59.726] Timer tick, asking Buildbucket for the build status
[09:06:59.862] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:59.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:88:0) after 1m0s
[09:08:00.040] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:88:0)
[09:08:00.041] Timer tick, asking Buildbucket for the build status
[09:08:00.146] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:00.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:89:0) after 1m0s
[09:09:00.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:89:0)
[09:09:00.217] Timer tick, asking Buildbucket for the build status
[09:09:00.394] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:00.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:90:0) after 1m0s
[09:10:00.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:90:0)
[09:10:00.433] Timer tick, asking Buildbucket for the build status
[09:10:00.514] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:00.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:91:0) after 1m0s
[09:11:00.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:91:0)
[09:11:00.579] Timer tick, asking Buildbucket for the build status
[09:11:01.938] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:01.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:92:0) after 1m0s
[09:12:02.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:92:0)
[09:12:02.474] Timer tick, asking Buildbucket for the build status
[09:12:02.587] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:02.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:93:0) after 1m0s
[09:13:02.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:93:0)
[09:13:02.687] Timer tick, asking Buildbucket for the build status
[09:13:02.752] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:02.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:94:0) after 1m0s
[09:14:02.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:94:0)
[09:14:02.842] Timer tick, asking Buildbucket for the build status
[09:14:02.916] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:02.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:95:0) after 1m0s
[09:15:03.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:95:0)
[09:15:03.214] Timer tick, asking Buildbucket for the build status
[09:15:03.479] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:03.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:96:0) after 1m0s
[09:16:03.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:96:0)
[09:16:03.560] Timer tick, asking Buildbucket for the build status
[09:16:03.660] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:03.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:97:0) after 1m0s
[09:17:03.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:97:0)
[09:17:03.793] Timer tick, asking Buildbucket for the build status
[09:17:04.239] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:04.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:98:0) after 1m0s
[09:18:04.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:98:0)
[09:18:04.389] Timer tick, asking Buildbucket for the build status
[09:18:04.496] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:04.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:99:0) after 1m0s
[09:19:04.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:99:0)
[09:19:04.507] Timer tick, asking Buildbucket for the build status
[09:19:04.598] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:04.598] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:100:0) after 1m0s
[09:20:04.643] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:100:0)
[09:20:04.643] Timer tick, asking Buildbucket for the build status
[09:20:04.868] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:04.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:101:0) after 1m0s
[09:21:04.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:101:0)
[09:21:04.891] Timer tick, asking Buildbucket for the build status
[09:21:05.038] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:05.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:102:0) after 1m0s
[09:22:05.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:102:0)
[09:22:05.666] Timer tick, asking Buildbucket for the build status
[09:22:05.921] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:05.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:103:0) after 1m0s
[09:23:06.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:103:0)
[09:23:06.000] Timer tick, asking Buildbucket for the build status
[09:23:06.227] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:06.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:104:0) after 1m0s
[09:24:06.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:104:0)
[09:24:06.288] Timer tick, asking Buildbucket for the build status
[09:24:06.567] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:06.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:105:0) after 1m0s
[09:25:06.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:105:0)
[09:25:06.703] Timer tick, asking Buildbucket for the build status
[09:25:06.808] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:06.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:106:0) after 1m0s
[09:26:06.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:106:0)
[09:26:06.870] Timer tick, asking Buildbucket for the build status
[09:26:06.965] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:06.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:107:0) after 1m0s
[09:27:07.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:107:0)
[09:27:07.151] Timer tick, asking Buildbucket for the build status
[09:27:07.268] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:07.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:108:0) after 1m0s
[09:28:07.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:108:0)
[09:28:07.890] Timer tick, asking Buildbucket for the build status
[09:28:08.921] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:08.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:109:0) after 1m0s
[09:29:08.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:109:0)
[09:29:08.995] Timer tick, asking Buildbucket for the build status
[09:29:09.056] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:09.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:110:0) after 1m0s
[09:30:09.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:110:0)
[09:30:09.648] Timer tick, asking Buildbucket for the build status
[09:30:09.811] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:09.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:111:0) after 1m0s
[09:31:09.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:111:0)
[09:31:09.904] Timer tick, asking Buildbucket for the build status
[09:31:09.980] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:09.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:112:0) after 1m0s
[09:32:10.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:112:0)
[09:32:10.034] Timer tick, asking Buildbucket for the build status
[09:32:10.185] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:10.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:113:0) after 1m0s
[09:33:10.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:113:0)
[09:33:10.661] Timer tick, asking Buildbucket for the build status
[09:33:10.803] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:10.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:114:0) after 1m0s
[09:34:11.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:114:0)
[09:34:11.001] Timer tick, asking Buildbucket for the build status
[09:34:11.471] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:11.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:115:0) after 1m0s
[09:35:11.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:115:0)
[09:35:11.480] Timer tick, asking Buildbucket for the build status
[09:35:11.537] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:11.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:116:0) after 1m0s
[09:36:11.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:116:0)
[09:36:11.602] Timer tick, asking Buildbucket for the build status
[09:36:11.696] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:11.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:117:0) after 1m0s
[09:37:11.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:117:0)
[09:37:11.754] Timer tick, asking Buildbucket for the build status
[09:37:12.087] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:12.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:118:0) after 1m0s
[09:38:12.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:118:0)
[09:38:12.174] Timer tick, asking Buildbucket for the build status
[09:38:12.242] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:12.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:119:0) after 1m0s
[09:39:12.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:119:0)
[09:39:12.275] Timer tick, asking Buildbucket for the build status
[09:39:12.336] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:12.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:120:0) after 1m0s
[09:40:12.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:120:0)
[09:40:12.747] Timer tick, asking Buildbucket for the build status
[09:40:12.887] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:12.887] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:121:0) after 1m0s
[09:41:13.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:121:0)
[09:41:13.519] Timer tick, asking Buildbucket for the build status
[09:41:13.724] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:13.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:122:0) after 1m0s
[09:42:14.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:122:0)
[09:42:14.111] Timer tick, asking Buildbucket for the build status
[09:42:14.258] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:14.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:123:0) after 1m0s
[09:43:14.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:123:0)
[09:43:14.398] Timer tick, asking Buildbucket for the build status
[09:43:14.461] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:14.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:124:0) after 1m0s
[09:44:14.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:124:0)
[09:44:14.579] Timer tick, asking Buildbucket for the build status
[09:44:14.744] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:14.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:125:0) after 1m0s
[09:45:14.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:125:0)
[09:45:14.873] Timer tick, asking Buildbucket for the build status
[09:45:15.112] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:15.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:126:0) after 1m0s
[09:46:15.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:126:0)
[09:46:15.287] Timer tick, asking Buildbucket for the build status
[09:46:15.423] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:15.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:127:0) after 1m0s
[09:47:15.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:127:0)
[09:47:15.613] Timer tick, asking Buildbucket for the build status
[09:47:15.731] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:15.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:128:0) after 1m0s
[09:48:16.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:128:0)
[09:48:16.003] Timer tick, asking Buildbucket for the build status
[09:48:16.060] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:16.060] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:129:0) after 1m0s
[09:49:16.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:129:0)
[09:49:16.367] Timer tick, asking Buildbucket for the build status
[09:49:16.819] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:16.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:130:0) after 1m0s
[09:50:17.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:130:0)
[09:50:17.465] Timer tick, asking Buildbucket for the build status
[09:50:17.707] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:17.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:131:0) after 1m0s
[09:51:17.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:131:0)
[09:51:17.805] Timer tick, asking Buildbucket for the build status
[09:51:17.999] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:17.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:132:0) after 1m0s
[09:52:18.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:132:0)
[09:52:18.026] Timer tick, asking Buildbucket for the build status
[09:52:18.171] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:18.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:133:0) after 1m0s
[09:53:18.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:133:0)
[09:53:18.230] Timer tick, asking Buildbucket for the build status
[09:53:18.479] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:18.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:134:0) after 1m0s
[09:54:18.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:134:0)
[09:54:18.636] Timer tick, asking Buildbucket for the build status
[09:54:18.742] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:18.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:135:0) after 1m0s
[09:55:18.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:135:0)
[09:55:18.920] Timer tick, asking Buildbucket for the build status
[09:55:18.995] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:18.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:136:0) after 1m0s
[09:56:19.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:136:0)
[09:56:19.166] Timer tick, asking Buildbucket for the build status
[09:56:19.261] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:19.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:137:0) after 1m0s
[09:57:19.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:137:0)
[09:57:19.277] Timer tick, asking Buildbucket for the build status
[09:57:19.453] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:19.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:138:0) after 1m0s
[09:58:19.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:138:0)
[09:58:19.522] Timer tick, asking Buildbucket for the build status
[09:58:19.668] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:19.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:139:0) after 1m0s
[09:59:19.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:139:0)
[09:59:19.816] Timer tick, asking Buildbucket for the build status
[09:59:20.509] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:20.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:140:0) after 1m0s
[10:00:20.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:140:0)
[10:00:20.678] Timer tick, asking Buildbucket for the build status
[10:00:20.796] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:20.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:141:0) after 1m0s
[10:01:20.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:141:0)
[10:01:20.866] Timer tick, asking Buildbucket for the build status
[10:01:20.988] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:20.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:142:0) after 1m0s
[10:02:21.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:142:0)
[10:02:21.141] Timer tick, asking Buildbucket for the build status
[10:02:21.262] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:21.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:143:0) after 1m0s
[10:03:21.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:143:0)
[10:03:21.392] Timer tick, asking Buildbucket for the build status
[10:03:21.592] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:21.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:144:0) after 1m0s
[10:04:21.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:144:0)
[10:04:21.776] Timer tick, asking Buildbucket for the build status
[10:04:21.922] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:21.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:145:0) after 1m0s
[10:05:22.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:145:0)
[10:05:22.158] Timer tick, asking Buildbucket for the build status
[10:05:22.285] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:22.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:146:0) after 1m0s
[10:06:22.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:146:0)
[10:06:22.348] Timer tick, asking Buildbucket for the build status
[10:06:22.532] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:22.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:147:0) after 1m0s
[10:07:22.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:147:0)
[10:07:22.738] Timer tick, asking Buildbucket for the build status
[10:07:22.854] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:22.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:148:0) after 1m0s
[10:08:23.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:148:0)
[10:08:23.059] Timer tick, asking Buildbucket for the build status
[10:08:23.187] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:23.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:149:0) after 1m0s
[10:09:23.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:149:0)
[10:09:23.182] Timer tick, asking Buildbucket for the build status
[10:09:23.490] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:23.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:150:0) after 1m0s
[10:10:24.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:150:0)
[10:10:24.724] Timer tick, asking Buildbucket for the build status
[10:10:24.806] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:24.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:151:0) after 1m0s
[10:11:25.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:151:0)
[10:11:25.330] Timer tick, asking Buildbucket for the build status
[10:11:25.438] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:25.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:152:0) after 1m0s
[10:12:25.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:152:0)
[10:12:25.651] Timer tick, asking Buildbucket for the build status
[10:12:25.753] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:25.753] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:153:0) after 1m0s
[10:13:25.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:153:0)
[10:13:25.913] Timer tick, asking Buildbucket for the build status
[10:13:26.039] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:26.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:154:0) after 1m0s
[10:14:26.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:154:0)
[10:14:26.212] Timer tick, asking Buildbucket for the build status
[10:14:26.301] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:26.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:155:0) after 1m0s
[10:15:26.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:155:0)
[10:15:26.459] Timer tick, asking Buildbucket for the build status
[10:15:26.527] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:26.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:156:0) after 1m0s
[10:16:26.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:156:0)
[10:16:26.748] Timer tick, asking Buildbucket for the build status
[10:16:26.821] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:26.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:157:0) after 1m0s
[10:17:27.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:157:0)
[10:17:27.327] Timer tick, asking Buildbucket for the build status
[10:17:27.513] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:27.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:158:0) after 1m0s
[10:18:27.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:158:0)
[10:18:27.868] Timer tick, asking Buildbucket for the build status
[10:18:27.954] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:27.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:159:0) after 1m0s
[10:19:28.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:159:0)
[10:19:28.471] Timer tick, asking Buildbucket for the build status
[10:19:28.873] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:28.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:160:0) after 1m0s
[10:20:29.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:160:0)
[10:20:29.041] Timer tick, asking Buildbucket for the build status
[10:20:29.176] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:29.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:161:0) after 1m0s
[10:21:29.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:161:0)
[10:21:29.552] Timer tick, asking Buildbucket for the build status
[10:21:29.610] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:29.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:162:0) after 1m0s
[10:22:29.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:162:0)
[10:22:29.718] Timer tick, asking Buildbucket for the build status
[10:22:29.977] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:29.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:163:0) after 1m0s
[10:23:30.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:163:0)
[10:23:30.916] Timer tick, asking Buildbucket for the build status
[10:23:31.456] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:31.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:164:0) after 1m0s
[10:24:32.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:164:0)
[10:24:32.066] Timer tick, asking Buildbucket for the build status
[10:24:32.391] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:32.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:165:0) after 1m0s
[10:25:32.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:165:0)
[10:25:32.495] Timer tick, asking Buildbucket for the build status
[10:25:32.584] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:32.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:166:0) after 1m0s
[10:26:32.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:166:0)
[10:26:32.625] Timer tick, asking Buildbucket for the build status
[10:26:32.976] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:32.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:167:0) after 1m0s
[10:27:33.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:167:0)
[10:27:33.084] Timer tick, asking Buildbucket for the build status
[10:27:33.247] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:33.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:168:0) after 1m0s
[10:28:33.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:168:0)
[10:28:33.282] Timer tick, asking Buildbucket for the build status
[10:28:33.361] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:33.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:169:0) after 1m0s
[10:29:33.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:169:0)
[10:29:33.732] Timer tick, asking Buildbucket for the build status
[10:29:33.852] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:33.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:170:0) after 1m0s
[10:30:34.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:170:0)
[10:30:34.463] Timer tick, asking Buildbucket for the build status
[10:30:34.550] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:34.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:171:0) after 1m0s
[10:31:34.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:171:0)
[10:31:34.875] Timer tick, asking Buildbucket for the build status
[10:31:34.971] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:34.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:172:0) after 1m0s
[10:32:35.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:172:0)
[10:32:35.102] Timer tick, asking Buildbucket for the build status
[10:32:35.269] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:35.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:173:0) after 1m0s
[10:33:35.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:173:0)
[10:33:35.564] Timer tick, asking Buildbucket for the build status
[10:33:35.648] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:35.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:174:0) after 1m0s
[10:34:35.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:174:0)
[10:34:35.778] Timer tick, asking Buildbucket for the build status
[10:34:35.841] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:35.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:175:0) after 1m0s
[10:35:35.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:175:0)
[10:35:35.895] Timer tick, asking Buildbucket for the build status
[10:35:35.975] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:35.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:176:0) after 1m0s
[10:36:36.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:176:0)
[10:36:36.527] Timer tick, asking Buildbucket for the build status
[10:36:36.687] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:36.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:177:0) after 1m0s
[10:37:36.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:177:0)
[10:37:36.819] Timer tick, asking Buildbucket for the build status
[10:37:37.111] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:37.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:178:0) after 1m0s
[10:38:37.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:178:0)
[10:38:37.208] Timer tick, asking Buildbucket for the build status
[10:38:37.275] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:37.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:179:0) after 1m0s
[10:39:37.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:179:0)
[10:39:37.380] Timer tick, asking Buildbucket for the build status
[10:39:37.452] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:37.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:180:0) after 1m0s
[10:40:37.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:180:0)
[10:40:37.529] Timer tick, asking Buildbucket for the build status
[10:40:37.700] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:37.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:181:0) after 1m0s
[10:41:37.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:181:0)
[10:41:37.820] Timer tick, asking Buildbucket for the build status
[10:41:37.983] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:37.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:182:0) after 1m0s
[10:42:38.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:182:0)
[10:42:38.450] Timer tick, asking Buildbucket for the build status
[10:42:38.588] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:38.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:183:0) after 1m0s
[10:43:38.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:183:0)
[10:43:38.655] Timer tick, asking Buildbucket for the build status
[10:43:38.884] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:38.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:184:0) after 1m0s
[10:44:38.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:184:0)
[10:44:38.909] Timer tick, asking Buildbucket for the build status
[10:44:38.973] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:38.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:185:0) after 1m0s
[10:45:39.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:185:0)
[10:45:39.093] Timer tick, asking Buildbucket for the build status
[10:45:39.171] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:39.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:186:0) after 1m0s
[10:46:39.180] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:186:0)
[10:46:39.180] Timer tick, asking Buildbucket for the build status
[10:46:39.252] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:39.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:187:0) after 1m0s
[10:47:39.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:187:0)
[10:47:39.402] Timer tick, asking Buildbucket for the build status
[10:47:39.562] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:39.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:188:0) after 1m0s
[10:48:39.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:188:0)
[10:48:39.794] Timer tick, asking Buildbucket for the build status
[10:48:39.872] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:39.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:189:0) after 1m0s
[10:49:40.015] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:189:0)
[10:49:40.015] Timer tick, asking Buildbucket for the build status
[10:49:40.151] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:40.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:190:0) after 1m0s
[10:50:40.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:190:0)
[10:50:40.216] Timer tick, asking Buildbucket for the build status
[10:50:40.316] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:40.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:191:0) after 1m0s
[10:51:40.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:191:0)
[10:51:40.395] Timer tick, asking Buildbucket for the build status
[10:51:40.581] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:40.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:192:0) after 1m0s
[10:52:40.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:192:0)
[10:52:40.690] Timer tick, asking Buildbucket for the build status
[10:52:41.084] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:41.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:193:0) after 1m0s
[10:53:41.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:193:0)
[10:53:41.113] Timer tick, asking Buildbucket for the build status
[10:53:41.681] Build 8870286625287139520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:41.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035716688493182128:194:0) after 1m0s
[10:53:47.000] Received PubSub notification, asking Buildbucket for the build status
[10:53:48.144] Build 8870286625287139520: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:53:48.144] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1599044025787417",
    "created_by": "project:infra",
    "created_ts": "1599032488509255",
    "id": "8870286625287139520",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4252.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"b0f0b8d7-4cea-4b03-bfaf-95e385ecc90b\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4252.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-07ed\"], \"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\": [\"5507-6e8d655\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1599032492142605",
    "status": "COMPLETED",
    "status_changed_ts": "1599044026400775",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9035716688493182128",
      "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/8870286625287139520/+/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:4e6694fd31cc4410",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1599044026421655",
    "url": "https://ci.chromium.org/b/8870286625287139520",
    "utcnow_ts": "1599044028112464"
  }
}
[10:53:48.144] Invocation finished in 3h12m22.076135383s with status SUCCEEDED