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

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

{
  "version": "89.0.4389.95"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[19:06:24.603] New invocation is queued and will start shortly
[19:06:24.603] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[19:06:25.679] Starting the invocation (attempt 1)
[19:06:25.727] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:06:25.727] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:06:25.728] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9017825991191628064",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"89.0.4389.95\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"42ffb497-e350-48d7-876d-d26a96726b05\",\"title\":\"publish_tarball/0\"}]},\"version\":\"89.0.4389.95\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9017825991191628064",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[19:06:26.514] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1616094385809813",
    "id": "8852395929264427552",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"89.0.4389.95\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"42ffb497-e350-48d7-876d-d26a96726b05\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"89.0.4389.95\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1616094386222065",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9017825991191628064",
      "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/8852395929264427552/+/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": "1616094386222182",
    "url": "https://ci.chromium.org/b/8852395929264427552",
    "utcnow_ts": "1616094386500540"
  }
}
[19:06:26.514] Task URL: https://ci.chromium.org/b/8852395929264427552
[19:06:26.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:2:0) after 1m0s
[19:07:01.203] Received PubSub notification, asking Buildbucket for the build status
[19:07:01.464] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:26.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:2:0)
[19:07:26.533] Timer tick, asking Buildbucket for the build status
[19:07:26.607] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:26.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:4:0) after 1m0s
[19:08:26.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:4:0)
[19:08:26.653] Timer tick, asking Buildbucket for the build status
[19:08:26.738] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:26.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:5:0) after 1m0s
[19:09:26.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:5:0)
[19:09:26.822] Timer tick, asking Buildbucket for the build status
[19:09:26.889] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:26.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:6:0) after 1m0s
[19:10:27.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:6:0)
[19:10:27.215] Timer tick, asking Buildbucket for the build status
[19:10:27.330] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:27.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:7:0) after 1m0s
[19:11:27.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:7:0)
[19:11:27.667] Timer tick, asking Buildbucket for the build status
[19:11:27.750] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:27.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:8:0) after 1m0s
[19:12:28.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:8:0)
[19:12:28.115] Timer tick, asking Buildbucket for the build status
[19:12:28.223] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:28.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:9:0) after 1m0s
[19:13:28.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:9:0)
[19:13:28.467] Timer tick, asking Buildbucket for the build status
[19:13:28.526] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:28.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:10:0) after 1m0s
[19:14:28.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:10:0)
[19:14:28.885] Timer tick, asking Buildbucket for the build status
[19:14:28.960] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:28.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:11:0) after 1m0s
[19:15:29.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:11:0)
[19:15:29.225] Timer tick, asking Buildbucket for the build status
[19:15:29.293] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:29.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:12:0) after 1m0s
[19:16:29.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:12:0)
[19:16:29.438] Timer tick, asking Buildbucket for the build status
[19:16:29.816] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:29.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:13:0) after 1m0s
[19:17:30.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:13:0)
[19:17:30.137] Timer tick, asking Buildbucket for the build status
[19:17:30.232] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:30.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:14:0) after 1m0s
[19:18:30.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:14:0)
[19:18:30.324] Timer tick, asking Buildbucket for the build status
[19:18:30.918] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:30.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:15:0) after 1m0s
[19:19:30.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:15:0)
[19:19:30.932] Timer tick, asking Buildbucket for the build status
[19:19:31.277] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:31.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:16:0) after 1m0s
[19:20:31.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:16:0)
[19:20:31.338] Timer tick, asking Buildbucket for the build status
[19:20:31.420] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:31.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:17:0) after 1m0s
[19:21:31.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:17:0)
[19:21:31.470] Timer tick, asking Buildbucket for the build status
[19:21:31.574] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:31.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:18:0) after 1m0s
[19:22:31.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:18:0)
[19:22:31.696] Timer tick, asking Buildbucket for the build status
[19:22:31.825] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:31.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:19:0) after 1m0s
[19:23:31.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:19:0)
[19:23:31.895] Timer tick, asking Buildbucket for the build status
[19:23:32.130] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:32.130] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:20:0) after 1m0s
[19:24:32.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:20:0)
[19:24:32.191] Timer tick, asking Buildbucket for the build status
[19:24:32.353] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:32.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:21:0) after 1m0s
[19:25:32.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:21:0)
[19:25:32.349] Timer tick, asking Buildbucket for the build status
[19:25:32.431] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:32.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:22:0) after 1m0s
[19:26:32.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:22:0)
[19:26:32.530] Timer tick, asking Buildbucket for the build status
[19:26:32.605] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:32.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:23:0) after 1m0s
[19:27:32.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:23:0)
[19:27:32.623] Timer tick, asking Buildbucket for the build status
[19:27:32.692] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:32.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:24:0) after 1m0s
[19:28:32.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:24:0)
[19:28:32.763] Timer tick, asking Buildbucket for the build status
[19:28:32.891] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:32.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:25:0) after 1m0s
[19:29:33.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:25:0)
[19:29:33.037] Timer tick, asking Buildbucket for the build status
[19:29:33.329] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:33.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:26:0) after 1m0s
[19:30:33.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:26:0)
[19:30:33.380] Timer tick, asking Buildbucket for the build status
[19:30:33.531] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:33.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:27:0) after 1m0s
[19:31:33.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:27:0)
[19:31:33.572] Timer tick, asking Buildbucket for the build status
[19:31:33.791] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:33.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:28:0) after 1m0s
[19:32:33.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:28:0)
[19:32:33.808] Timer tick, asking Buildbucket for the build status
[19:32:33.909] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:33.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:29:0) after 1m0s
[19:33:33.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:29:0)
[19:33:33.928] Timer tick, asking Buildbucket for the build status
[19:33:34.249] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:34.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:30:0) after 1m0s
[19:34:34.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:30:0)
[19:34:34.301] Timer tick, asking Buildbucket for the build status
[19:34:34.439] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:34.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:31:0) after 1m0s
[19:35:34.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:31:0)
[19:35:34.464] Timer tick, asking Buildbucket for the build status
[19:35:34.527] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:34.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:32:0) after 1m0s
[19:36:34.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:32:0)
[19:36:34.600] Timer tick, asking Buildbucket for the build status
[19:36:34.683] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:34.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:33:0) after 1m0s
[19:37:34.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:33:0)
[19:37:34.683] Timer tick, asking Buildbucket for the build status
[19:37:34.752] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:34.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:34:0) after 1m0s
[19:38:34.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:34:0)
[19:38:34.760] Timer tick, asking Buildbucket for the build status
[19:38:34.868] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:34.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:35:0) after 1m0s
[19:39:34.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:35:0)
[19:39:34.887] Timer tick, asking Buildbucket for the build status
[19:39:34.954] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:34.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:36:0) after 1m0s
[19:40:34.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:36:0)
[19:40:34.997] Timer tick, asking Buildbucket for the build status
[19:40:35.193] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:35.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:37:0) after 1m0s
[19:41:35.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:37:0)
[19:41:35.292] Timer tick, asking Buildbucket for the build status
[19:41:35.522] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:35.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:38:0) after 1m0s
[19:42:35.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:38:0)
[19:42:35.550] Timer tick, asking Buildbucket for the build status
[19:42:35.629] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:35.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:39:0) after 1m0s
[19:43:35.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:39:0)
[19:43:35.622] Timer tick, asking Buildbucket for the build status
[19:43:35.681] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:35.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:40:0) after 1m0s
[19:44:35.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:40:0)
[19:44:35.724] Timer tick, asking Buildbucket for the build status
[19:44:35.833] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:35.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:41:0) after 1m0s
[19:45:35.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:41:0)
[19:45:35.919] Timer tick, asking Buildbucket for the build status
[19:45:35.989] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:35.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:42:0) after 1m0s
[19:46:36.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:42:0)
[19:46:36.097] Timer tick, asking Buildbucket for the build status
[19:46:36.214] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:36.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:43:0) after 1m0s
[19:47:36.220] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:43:0)
[19:47:36.220] Timer tick, asking Buildbucket for the build status
[19:47:36.310] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:36.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:44:0) after 1m0s
[19:48:36.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:44:0)
[19:48:36.382] Timer tick, asking Buildbucket for the build status
[19:48:36.445] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:36.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:45:0) after 1m0s
[19:49:36.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:45:0)
[19:49:36.572] Timer tick, asking Buildbucket for the build status
[19:49:36.667] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:36.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:46:0) after 1m0s
[19:50:36.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:46:0)
[19:50:36.737] Timer tick, asking Buildbucket for the build status
[19:50:36.805] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:36.805] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:47:0) after 1m0s
[19:51:36.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:47:0)
[19:51:36.879] Timer tick, asking Buildbucket for the build status
[19:51:36.971] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:36.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:48:0) after 1m0s
[19:52:37.019] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:48:0)
[19:52:37.019] Timer tick, asking Buildbucket for the build status
[19:52:37.114] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:37.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:49:0) after 1m0s
[19:53:37.121] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:49:0)
[19:53:37.121] Timer tick, asking Buildbucket for the build status
[19:53:37.208] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:37.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:50:0) after 1m0s
[19:54:37.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:50:0)
[19:54:37.239] Timer tick, asking Buildbucket for the build status
[19:54:37.528] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:37.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:51:0) after 1m0s
[19:55:37.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:51:0)
[19:55:37.552] Timer tick, asking Buildbucket for the build status
[19:55:37.653] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:37.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:52:0) after 1m0s
[19:56:37.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:52:0)
[19:56:37.718] Timer tick, asking Buildbucket for the build status
[19:56:37.784] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:37.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:53:0) after 1m0s
[19:57:37.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:53:0)
[19:57:37.831] Timer tick, asking Buildbucket for the build status
[19:57:37.950] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:37.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:54:0) after 1m0s
[19:58:37.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:54:0)
[19:58:37.984] Timer tick, asking Buildbucket for the build status
[19:58:38.060] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:38.060] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:55:0) after 1m0s
[19:59:38.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:55:0)
[19:59:38.172] Timer tick, asking Buildbucket for the build status
[19:59:38.250] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:38.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:56:0) after 1m0s
[20:00:38.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:56:0)
[20:00:38.283] Timer tick, asking Buildbucket for the build status
[20:00:38.350] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:38.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:57:0) after 1m0s
[20:01:38.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:57:0)
[20:01:38.370] Timer tick, asking Buildbucket for the build status
[20:01:38.602] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:38.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:58:0) after 1m0s
[20:02:38.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:58:0)
[20:02:38.734] Timer tick, asking Buildbucket for the build status
[20:02:38.939] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:38.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:59:0) after 1m0s
[20:03:39.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:59:0)
[20:03:39.045] Timer tick, asking Buildbucket for the build status
[20:03:39.107] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:39.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:60:0) after 1m0s
[20:04:39.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:60:0)
[20:04:39.175] Timer tick, asking Buildbucket for the build status
[20:04:39.253] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:39.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:61:0) after 1m0s
[20:05:39.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:61:0)
[20:05:39.294] Timer tick, asking Buildbucket for the build status
[20:05:39.364] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:39.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:62:0) after 1m0s
[20:06:39.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:62:0)
[20:06:39.402] Timer tick, asking Buildbucket for the build status
[20:06:39.519] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:39.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:63:0) after 1m0s
[20:07:39.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:63:0)
[20:07:39.798] Timer tick, asking Buildbucket for the build status
[20:07:39.913] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:39.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:64:0) after 1m0s
[20:08:39.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:64:0)
[20:08:39.927] Timer tick, asking Buildbucket for the build status
[20:08:39.994] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:39.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:65:0) after 1m0s
[20:09:40.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:65:0)
[20:09:40.089] Timer tick, asking Buildbucket for the build status
[20:09:40.245] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:40.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:66:0) after 1m0s
[20:10:40.269] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:66:0)
[20:10:40.269] Timer tick, asking Buildbucket for the build status
[20:10:40.346] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:40.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:67:0) after 1m0s
[20:11:40.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:67:0)
[20:11:40.368] Timer tick, asking Buildbucket for the build status
[20:11:40.488] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:40.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:68:0) after 1m0s
[20:12:40.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:68:0)
[20:12:40.607] Timer tick, asking Buildbucket for the build status
[20:12:40.678] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:40.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:69:0) after 1m0s
[20:13:40.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:69:0)
[20:13:40.701] Timer tick, asking Buildbucket for the build status
[20:13:40.780] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:40.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:70:0) after 1m0s
[20:14:40.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:70:0)
[20:14:40.899] Timer tick, asking Buildbucket for the build status
[20:14:40.964] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:40.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:71:0) after 1m0s
[20:15:41.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:71:0)
[20:15:41.028] Timer tick, asking Buildbucket for the build status
[20:15:41.161] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:41.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:72:0) after 1m0s
[20:16:41.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:72:0)
[20:16:41.197] Timer tick, asking Buildbucket for the build status
[20:16:41.327] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:41.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:73:0) after 1m0s
[20:17:41.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:73:0)
[20:17:41.354] Timer tick, asking Buildbucket for the build status
[20:17:41.519] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:41.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:74:0) after 1m0s
[20:18:41.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:74:0)
[20:18:41.541] Timer tick, asking Buildbucket for the build status
[20:18:41.729] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:41.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:75:0) after 1m0s
[20:19:41.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:75:0)
[20:19:41.805] Timer tick, asking Buildbucket for the build status
[20:19:41.918] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:41.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:76:0) after 1m0s
[20:20:41.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:76:0)
[20:20:41.932] Timer tick, asking Buildbucket for the build status
[20:20:41.999] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:41.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:77:0) after 1m0s
[20:21:42.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:77:0)
[20:21:42.126] Timer tick, asking Buildbucket for the build status
[20:21:42.532] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:42.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:78:0) after 1m0s
[20:22:42.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:78:0)
[20:22:42.601] Timer tick, asking Buildbucket for the build status
[20:22:42.870] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:42.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:79:0) after 1m0s
[20:23:43.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:79:0)
[20:23:43.103] Timer tick, asking Buildbucket for the build status
[20:23:43.330] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:43.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:80:0) after 1m0s
[20:24:43.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:80:0)
[20:24:43.415] Timer tick, asking Buildbucket for the build status
[20:24:43.486] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:43.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:81:0) after 1m0s
[20:25:43.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:81:0)
[20:25:43.696] Timer tick, asking Buildbucket for the build status
[20:25:43.843] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:43.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:82:0) after 1m0s
[20:26:43.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:82:0)
[20:26:43.893] Timer tick, asking Buildbucket for the build status
[20:26:44.361] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:44.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:83:0) after 1m0s
[20:27:45.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:83:0)
[20:27:45.161] Timer tick, asking Buildbucket for the build status
[20:27:45.232] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:45.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:84:0) after 1m0s
[20:28:45.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:84:0)
[20:28:45.364] Timer tick, asking Buildbucket for the build status
[20:28:45.552] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:45.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:85:0) after 1m0s
[20:29:45.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:85:0)
[20:29:45.578] Timer tick, asking Buildbucket for the build status
[20:29:45.665] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:45.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:86:0) after 1m0s
[20:30:45.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:86:0)
[20:30:45.757] Timer tick, asking Buildbucket for the build status
[20:30:45.831] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:45.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:87:0) after 1m0s
[20:31:45.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:87:0)
[20:31:45.925] Timer tick, asking Buildbucket for the build status
[20:31:46.041] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:46.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:88:0) after 1m0s
[20:32:46.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:88:0)
[20:32:46.110] Timer tick, asking Buildbucket for the build status
[20:32:46.186] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:46.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:89:0) after 1m0s
[20:33:46.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:89:0)
[20:33:46.466] Timer tick, asking Buildbucket for the build status
[20:33:46.689] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:46.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:90:0) after 1m0s
[20:34:47.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:90:0)
[20:34:47.106] Timer tick, asking Buildbucket for the build status
[20:34:47.190] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:47.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:91:0) after 1m0s
[20:35:47.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:91:0)
[20:35:47.342] Timer tick, asking Buildbucket for the build status
[20:35:47.434] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:47.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:92:0) after 1m0s
[20:36:47.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:92:0)
[20:36:47.539] Timer tick, asking Buildbucket for the build status
[20:36:48.128] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:48.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:93:0) after 1m0s
[20:37:48.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:93:0)
[20:37:48.257] Timer tick, asking Buildbucket for the build status
[20:37:48.323] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:48.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:94:0) after 1m0s
[20:38:48.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:94:0)
[20:38:48.398] Timer tick, asking Buildbucket for the build status
[20:38:48.465] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:48.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:95:0) after 1m0s
[20:39:48.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:95:0)
[20:39:48.575] Timer tick, asking Buildbucket for the build status
[20:39:48.656] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:48.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:96:0) after 1m0s
[20:40:48.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:96:0)
[20:40:48.763] Timer tick, asking Buildbucket for the build status
[20:40:48.865] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:48.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:97:0) after 1m0s
[20:41:48.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:97:0)
[20:41:48.982] Timer tick, asking Buildbucket for the build status
[20:41:49.286] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:49.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:98:0) after 1m0s
[20:42:49.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:98:0)
[20:42:49.391] Timer tick, asking Buildbucket for the build status
[20:42:49.488] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:49.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:99:0) after 1m0s
[20:43:49.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:99:0)
[20:43:49.518] Timer tick, asking Buildbucket for the build status
[20:43:49.585] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:49.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:100:0) after 1m0s
[20:44:49.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:100:0)
[20:44:49.591] Timer tick, asking Buildbucket for the build status
[20:44:49.661] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:49.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:101:0) after 1m0s
[20:45:49.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:101:0)
[20:45:49.720] Timer tick, asking Buildbucket for the build status
[20:45:49.802] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:49.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:102:0) after 1m0s
[20:46:49.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:102:0)
[20:46:49.835] Timer tick, asking Buildbucket for the build status
[20:46:49.924] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:49.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:103:0) after 1m0s
[20:47:49.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:103:0)
[20:47:49.973] Timer tick, asking Buildbucket for the build status
[20:47:50.058] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:50.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:104:0) after 1m0s
[20:48:50.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:104:0)
[20:48:50.106] Timer tick, asking Buildbucket for the build status
[20:48:50.188] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:50.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:105:0) after 1m0s
[20:49:50.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:105:0)
[20:49:50.239] Timer tick, asking Buildbucket for the build status
[20:49:50.354] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:50.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:106:0) after 1m0s
[20:50:50.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:106:0)
[20:50:50.368] Timer tick, asking Buildbucket for the build status
[20:50:50.448] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:50.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:107:0) after 1m0s
[20:51:50.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:107:0)
[20:51:50.518] Timer tick, asking Buildbucket for the build status
[20:51:50.600] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:50.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:108:0) after 1m0s
[20:52:50.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:108:0)
[20:52:50.660] Timer tick, asking Buildbucket for the build status
[20:52:50.753] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:50.753] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:109:0) after 1m0s
[20:53:50.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:109:0)
[20:53:50.754] Timer tick, asking Buildbucket for the build status
[20:53:51.019] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:51.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:110:0) after 1m0s
[20:54:51.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:110:0)
[20:54:51.024] Timer tick, asking Buildbucket for the build status
[20:54:51.271] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:51.271] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:111:0) after 1m0s
[20:55:51.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:111:0)
[20:55:51.316] Timer tick, asking Buildbucket for the build status
[20:55:51.394] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:51.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:112:0) after 1m0s
[20:56:51.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:112:0)
[20:56:51.412] Timer tick, asking Buildbucket for the build status
[20:56:51.499] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:51.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:113:0) after 1m0s
[20:57:51.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:113:0)
[20:57:51.560] Timer tick, asking Buildbucket for the build status
[20:57:51.636] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:51.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:114:0) after 1m0s
[20:58:51.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:114:0)
[20:58:51.688] Timer tick, asking Buildbucket for the build status
[20:58:51.765] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:51.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:115:0) after 1m0s
[20:59:51.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:115:0)
[20:59:51.821] Timer tick, asking Buildbucket for the build status
[20:59:51.883] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:51.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:116:0) after 1m0s
[21:00:51.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:116:0)
[21:00:51.909] Timer tick, asking Buildbucket for the build status
[21:00:51.990] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:51.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:117:0) after 1m0s
[21:01:52.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:117:0)
[21:01:52.041] Timer tick, asking Buildbucket for the build status
[21:01:52.186] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:52.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:118:0) after 1m0s
[21:02:52.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:118:0)
[21:02:52.176] Timer tick, asking Buildbucket for the build status
[21:02:52.240] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:52.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:119:0) after 1m0s
[21:03:52.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:119:0)
[21:03:52.256] Timer tick, asking Buildbucket for the build status
[21:03:52.561] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:52.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:120:0) after 1m0s
[21:04:52.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:120:0)
[21:04:52.539] Timer tick, asking Buildbucket for the build status
[21:04:52.868] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:52.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:121:0) after 1m0s
[21:05:52.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:121:0)
[21:05:52.881] Timer tick, asking Buildbucket for the build status
[21:05:52.966] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:52.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:122:0) after 1m0s
[21:06:52.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:122:0)
[21:06:52.965] Timer tick, asking Buildbucket for the build status
[21:06:53.076] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:53.076] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:123:0) after 1m0s
[21:07:53.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:123:0)
[21:07:53.107] Timer tick, asking Buildbucket for the build status
[21:07:53.253] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:53.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:124:0) after 1m0s
[21:08:53.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:124:0)
[21:08:53.250] Timer tick, asking Buildbucket for the build status
[21:08:53.341] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:53.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:125:0) after 1m0s
[21:09:53.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:125:0)
[21:09:53.394] Timer tick, asking Buildbucket for the build status
[21:09:53.615] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:53.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:126:0) after 1m0s
[21:10:53.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:126:0)
[21:10:53.638] Timer tick, asking Buildbucket for the build status
[21:10:54.634] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:54.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:127:0) after 1m0s
[21:11:54.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:127:0)
[21:11:54.697] Timer tick, asking Buildbucket for the build status
[21:11:54.784] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:54.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:128:0) after 1m0s
[21:12:54.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:128:0)
[21:12:54.759] Timer tick, asking Buildbucket for the build status
[21:12:54.825] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:54.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:129:0) after 1m0s
[21:13:54.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:129:0)
[21:13:54.851] Timer tick, asking Buildbucket for the build status
[21:13:54.997] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:54.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:130:0) after 1m0s
[21:14:55.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:130:0)
[21:14:55.018] Timer tick, asking Buildbucket for the build status
[21:14:55.080] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:55.080] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:131:0) after 1m0s
[21:15:55.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:131:0)
[21:15:55.109] Timer tick, asking Buildbucket for the build status
[21:15:55.171] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:55.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:132:0) after 1m0s
[21:16:55.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:132:0)
[21:16:55.216] Timer tick, asking Buildbucket for the build status
[21:16:55.310] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:55.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:133:0) after 1m0s
[21:17:55.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:133:0)
[21:17:55.412] Timer tick, asking Buildbucket for the build status
[21:17:55.481] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:55.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:134:0) after 1m0s
[21:18:55.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:134:0)
[21:18:55.462] Timer tick, asking Buildbucket for the build status
[21:18:55.654] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:55.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:135:0) after 1m0s
[21:19:55.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:135:0)
[21:19:55.684] Timer tick, asking Buildbucket for the build status
[21:19:55.971] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:55.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:136:0) after 1m0s
[21:20:55.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:136:0)
[21:20:55.958] Timer tick, asking Buildbucket for the build status
[21:20:56.120] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:56.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:137:0) after 1m0s
[21:21:56.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:137:0)
[21:21:56.141] Timer tick, asking Buildbucket for the build status
[21:21:56.252] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:56.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:138:0) after 1m0s
[21:22:56.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:138:0)
[21:22:56.272] Timer tick, asking Buildbucket for the build status
[21:22:56.362] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:56.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:139:0) after 1m0s
[21:23:56.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:139:0)
[21:23:56.404] Timer tick, asking Buildbucket for the build status
[21:23:56.462] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:56.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:140:0) after 1m0s
[21:24:56.456] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:140:0)
[21:24:56.456] Timer tick, asking Buildbucket for the build status
[21:24:56.609] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:56.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:141:0) after 1m0s
[21:25:56.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:141:0)
[21:25:56.633] Timer tick, asking Buildbucket for the build status
[21:25:56.896] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:56.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:142:0) after 1m0s
[21:26:56.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:142:0)
[21:26:56.937] Timer tick, asking Buildbucket for the build status
[21:26:57.015] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:57.015] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:143:0) after 1m0s
[21:27:56.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:143:0)
[21:27:56.995] Timer tick, asking Buildbucket for the build status
[21:27:57.056] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:57.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:144:0) after 1m0s
[21:28:57.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:144:0)
[21:28:57.091] Timer tick, asking Buildbucket for the build status
[21:28:57.165] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:57.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:145:0) after 1m0s
[21:29:57.170] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:145:0)
[21:29:57.170] Timer tick, asking Buildbucket for the build status
[21:29:57.264] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:57.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:146:0) after 1m0s
[21:30:57.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:146:0)
[21:30:57.286] Timer tick, asking Buildbucket for the build status
[21:30:57.365] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:57.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:147:0) after 1m0s
[21:31:57.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:147:0)
[21:31:57.402] Timer tick, asking Buildbucket for the build status
[21:31:57.546] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:57.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:148:0) after 1m0s
[21:32:57.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:148:0)
[21:32:57.601] Timer tick, asking Buildbucket for the build status
[21:32:57.694] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:57.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:149:0) after 1m0s
[21:33:57.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:149:0)
[21:33:57.719] Timer tick, asking Buildbucket for the build status
[21:33:57.781] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:57.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:150:0) after 1m0s
[21:34:57.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:150:0)
[21:34:57.813] Timer tick, asking Buildbucket for the build status
[21:34:57.875] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:57.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:151:0) after 1m0s
[21:35:57.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:151:0)
[21:35:57.962] Timer tick, asking Buildbucket for the build status
[21:35:58.049] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:58.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:152:0) after 1m0s
[21:36:58.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:152:0)
[21:36:58.139] Timer tick, asking Buildbucket for the build status
[21:36:58.221] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:58.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:153:0) after 1m0s
[21:37:58.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:153:0)
[21:37:58.250] Timer tick, asking Buildbucket for the build status
[21:37:58.352] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:58.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:154:0) after 1m0s
[21:38:58.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:154:0)
[21:38:58.445] Timer tick, asking Buildbucket for the build status
[21:38:58.509] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:58.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:155:0) after 1m0s
[21:39:58.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:155:0)
[21:39:58.608] Timer tick, asking Buildbucket for the build status
[21:39:58.670] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:58.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:156:0) after 1m0s
[21:40:58.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:156:0)
[21:40:58.801] Timer tick, asking Buildbucket for the build status
[21:40:58.932] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:58.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:157:0) after 1m0s
[21:41:59.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:157:0)
[21:41:59.000] Timer tick, asking Buildbucket for the build status
[21:41:59.272] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:59.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:158:0) after 1m0s
[21:42:59.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:158:0)
[21:42:59.331] Timer tick, asking Buildbucket for the build status
[21:42:59.401] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:59.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:159:0) after 1m0s
[21:43:59.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:159:0)
[21:43:59.431] Timer tick, asking Buildbucket for the build status
[21:43:59.497] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:59.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:160:0) after 1m0s
[21:44:59.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:160:0)
[21:44:59.519] Timer tick, asking Buildbucket for the build status
[21:44:59.711] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:59.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:161:0) after 1m0s
[21:45:59.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:161:0)
[21:45:59.775] Timer tick, asking Buildbucket for the build status
[21:45:59.858] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:59.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:162:0) after 1m0s
[21:46:59.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:162:0)
[21:46:59.879] Timer tick, asking Buildbucket for the build status
[21:46:59.950] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:59.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:163:0) after 1m0s
[21:48:00.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:163:0)
[21:48:00.008] Timer tick, asking Buildbucket for the build status
[21:48:00.260] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:00.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:164:0) after 1m0s
[21:49:00.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:164:0)
[21:49:00.313] Timer tick, asking Buildbucket for the build status
[21:49:00.382] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:00.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:165:0) after 1m0s
[21:50:00.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:165:0)
[21:50:00.405] Timer tick, asking Buildbucket for the build status
[21:50:00.604] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:00.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:166:0) after 1m0s
[21:51:00.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:166:0)
[21:51:00.642] Timer tick, asking Buildbucket for the build status
[21:51:00.740] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:00.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:167:0) after 1m0s
[21:52:00.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:167:0)
[21:52:00.813] Timer tick, asking Buildbucket for the build status
[21:52:00.938] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:00.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:168:0) after 1m0s
[21:53:00.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:168:0)
[21:53:00.997] Timer tick, asking Buildbucket for the build status
[21:53:05.247] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:05.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:169:0) after 1m0s
[21:54:05.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:169:0)
[21:54:05.424] Timer tick, asking Buildbucket for the build status
[21:54:05.505] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:05.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:170:0) after 1m0s
[21:55:05.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:170:0)
[21:55:05.655] Timer tick, asking Buildbucket for the build status
[21:55:05.944] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:05.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:171:0) after 1m0s
[21:56:06.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:171:0)
[21:56:06.003] Timer tick, asking Buildbucket for the build status
[21:56:06.075] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:06.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:172:0) after 1m0s
[21:57:06.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:172:0)
[21:57:06.061] Timer tick, asking Buildbucket for the build status
[21:57:06.146] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:06.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:173:0) after 1m0s
[21:58:06.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:173:0)
[21:58:06.174] Timer tick, asking Buildbucket for the build status
[21:58:06.289] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:06.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:174:0) after 1m0s
[21:59:06.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:174:0)
[21:59:06.389] Timer tick, asking Buildbucket for the build status
[21:59:06.535] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:06.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:175:0) after 1m0s
[22:00:06.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:175:0)
[22:00:06.808] Timer tick, asking Buildbucket for the build status
[22:00:06.875] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:06.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:176:0) after 1m0s
[22:01:07.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:176:0)
[22:01:07.035] Timer tick, asking Buildbucket for the build status
[22:01:07.126] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:07.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:177:0) after 1m0s
[22:02:07.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:177:0)
[22:02:07.306] Timer tick, asking Buildbucket for the build status
[22:02:07.395] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:07.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:178:0) after 1m0s
[22:03:07.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:178:0)
[22:03:07.664] Timer tick, asking Buildbucket for the build status
[22:03:07.799] Build 8852395929264427552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:07.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9017825991191628064:179:0) after 1m0s
[22:03:20.982] Received PubSub notification, asking Buildbucket for the build status
[22:03:21.055] Build 8852395929264427552: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:03:21.055] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1616105000535664",
    "created_by": "project:infra",
    "created_ts": "1616094385809813",
    "id": "8852395929264427552",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"89.0.4389.95\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"42ffb497-e350-48d7-876d-d26a96726b05\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"89.0.4389.95\"}}",
    "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-4f2e\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1616094420418311",
    "status": "COMPLETED",
    "status_changed_ts": "1616094420924545",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9017825991191628064",
      "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/8852395929264427552/+/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:525f8ce1afd6e510",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1616105000539281",
    "url": "https://ci.chromium.org/b/8852395929264427552",
    "utcnow_ts": "1616105001048019"
  }
}
[22:03:21.055] Invocation finished in 2h56m56.468175165s with status SUCCEEDED