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

• parent_buildername:publish_tarball
• user_agent:recipe

[07:56:07.315] New invocation is queued and will start shortly
[07:56:07.315] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[07:56:08.483] Starting the invocation (attempt 1)
[07:56:08.516] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:56:08.516] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:56:08.516] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9026927858714781952",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"89.0.4348.3\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"759f076d-92e8-44a4-a36c-a26266564e7e\",\"title\":\"publish_tarball/0\"}]},\"version\":\"89.0.4348.3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9026927858714781952",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[07:56:09.520] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1607414168660689",
    "id": "8861497796641216192",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"89.0.4348.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"759f076d-92e8-44a4-a36c-a26266564e7e\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"89.0.4348.3\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1607414169292119",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9026927858714781952",
      "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/8861497796641216192/+/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": "1607414169292286",
    "url": "https://ci.chromium.org/b/8861497796641216192",
    "utcnow_ts": "1607414169508545"
  }
}
[07:56:09.520] Task URL: https://ci.chromium.org/b/8861497796641216192
[07:56:09.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:2:0) after 1m0s
[07:57:04.831] Received PubSub notification, asking Buildbucket for the build status
[07:57:04.960] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:09.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:2:0)
[07:57:09.608] Timer tick, asking Buildbucket for the build status
[07:57:09.683] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:09.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:4:0) after 1m0s
[07:58:09.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:4:0)
[07:58:09.659] Timer tick, asking Buildbucket for the build status
[07:58:09.765] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:09.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:5:0) after 1m0s
[07:59:09.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:5:0)
[07:59:09.815] Timer tick, asking Buildbucket for the build status
[07:59:09.948] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:09.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:6:0) after 1m0s
[08:00:09.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:6:0)
[08:00:09.965] Timer tick, asking Buildbucket for the build status
[08:00:10.034] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:10.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:7:0) after 1m0s
[08:01:10.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:7:0)
[08:01:10.149] Timer tick, asking Buildbucket for the build status
[08:01:10.207] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:10.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:8:0) after 1m0s
[08:02:10.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:8:0)
[08:02:10.322] Timer tick, asking Buildbucket for the build status
[08:02:10.477] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:10.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:9:0) after 1m0s
[08:03:10.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:9:0)
[08:03:10.667] Timer tick, asking Buildbucket for the build status
[08:03:10.729] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:10.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:10:0) after 1m0s
[08:04:10.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:10:0)
[08:04:10.861] Timer tick, asking Buildbucket for the build status
[08:04:11.053] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:11.053] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:11:0) after 1m0s
[08:05:11.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:11:0)
[08:05:11.169] Timer tick, asking Buildbucket for the build status
[08:05:11.256] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:11.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:12:0) after 1m0s
[08:06:11.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:12:0)
[08:06:11.279] Timer tick, asking Buildbucket for the build status
[08:06:11.337] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:11.337] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:13:0) after 1m0s
[08:07:11.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:13:0)
[08:07:11.362] Timer tick, asking Buildbucket for the build status
[08:07:12.223] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:12.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:14:0) after 1m0s
[08:08:12.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:14:0)
[08:08:12.529] Timer tick, asking Buildbucket for the build status
[08:08:12.622] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:12.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:15:0) after 1m0s
[08:09:12.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:15:0)
[08:09:12.668] Timer tick, asking Buildbucket for the build status
[08:09:12.730] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:12.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:16:0) after 1m0s
[08:10:12.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:16:0)
[08:10:12.900] Timer tick, asking Buildbucket for the build status
[08:10:13.268] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:13.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:17:0) after 1m0s
[08:11:13.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:17:0)
[08:11:13.487] Timer tick, asking Buildbucket for the build status
[08:11:13.585] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:13.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:18:0) after 1m0s
[08:12:13.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:18:0)
[08:12:13.763] Timer tick, asking Buildbucket for the build status
[08:12:13.827] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:13.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:19:0) after 1m0s
[08:13:13.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:19:0)
[08:13:13.902] Timer tick, asking Buildbucket for the build status
[08:13:13.958] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:13.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:20:0) after 1m0s
[08:14:14.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:20:0)
[08:14:14.102] Timer tick, asking Buildbucket for the build status
[08:14:14.179] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:14.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:21:0) after 1m0s
[08:15:14.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:21:0)
[08:15:14.357] Timer tick, asking Buildbucket for the build status
[08:15:14.424] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:14.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:22:0) after 1m0s
[08:16:14.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:22:0)
[08:16:14.544] Timer tick, asking Buildbucket for the build status
[08:16:14.640] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:14.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:23:0) after 1m0s
[08:17:14.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:23:0)
[08:17:14.802] Timer tick, asking Buildbucket for the build status
[08:17:15.109] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:15.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:24:0) after 1m0s
[08:18:15.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:24:0)
[08:18:15.134] Timer tick, asking Buildbucket for the build status
[08:18:15.192] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:15.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:25:0) after 1m0s
[08:19:15.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:25:0)
[08:19:15.187] Timer tick, asking Buildbucket for the build status
[08:19:15.625] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:15.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:26:0) after 1m0s
[08:20:15.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:26:0)
[08:20:15.673] Timer tick, asking Buildbucket for the build status
[08:20:15.824] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:15.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:27:0) after 1m0s
[08:21:15.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:27:0)
[08:21:15.900] Timer tick, asking Buildbucket for the build status
[08:21:16.041] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:16.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:28:0) after 1m0s
[08:22:16.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:28:0)
[08:22:16.187] Timer tick, asking Buildbucket for the build status
[08:22:16.255] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:16.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:29:0) after 1m0s
[08:23:16.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:29:0)
[08:23:16.459] Timer tick, asking Buildbucket for the build status
[08:23:16.631] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:16.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:30:0) after 1m0s
[08:24:16.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:30:0)
[08:24:16.704] Timer tick, asking Buildbucket for the build status
[08:24:16.799] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:16.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:31:0) after 1m0s
[08:25:17.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:31:0)
[08:25:17.062] Timer tick, asking Buildbucket for the build status
[08:25:19.293] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:19.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:32:0) after 1m0s
[08:26:19.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:32:0)
[08:26:19.365] Timer tick, asking Buildbucket for the build status
[08:26:19.444] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:19.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:33:0) after 1m0s
[08:27:19.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:33:0)
[08:27:19.503] Timer tick, asking Buildbucket for the build status
[08:27:19.554] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:19.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:34:0) after 1m0s
[08:28:19.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:34:0)
[08:28:19.528] Timer tick, asking Buildbucket for the build status
[08:28:19.618] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:19.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:35:0) after 1m0s
[08:29:19.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:35:0)
[08:29:19.695] Timer tick, asking Buildbucket for the build status
[08:29:19.937] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:19.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:36:0) after 1m0s
[08:30:19.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:36:0)
[08:30:19.993] Timer tick, asking Buildbucket for the build status
[08:30:20.184] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:20.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:37:0) after 1m0s
[08:31:20.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:37:0)
[08:31:20.276] Timer tick, asking Buildbucket for the build status
[08:31:20.376] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:20.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:38:0) after 1m0s
[08:32:20.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:38:0)
[08:32:20.469] Timer tick, asking Buildbucket for the build status
[08:32:20.539] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:20.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:39:0) after 1m0s
[08:33:20.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:39:0)
[08:33:20.602] Timer tick, asking Buildbucket for the build status
[08:33:20.672] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:20.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:40:0) after 1m0s
[08:34:20.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:40:0)
[08:34:20.866] Timer tick, asking Buildbucket for the build status
[08:34:20.938] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:20.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:41:0) after 1m0s
[08:35:21.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:41:0)
[08:35:21.045] Timer tick, asking Buildbucket for the build status
[08:35:21.146] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:21.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:42:0) after 1m0s
[08:36:21.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:42:0)
[08:36:21.209] Timer tick, asking Buildbucket for the build status
[08:36:21.554] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:21.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:43:0) after 1m0s
[08:37:21.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:43:0)
[08:37:21.575] Timer tick, asking Buildbucket for the build status
[08:37:21.656] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:21.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:44:0) after 1m0s
[08:38:21.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:44:0)
[08:38:21.782] Timer tick, asking Buildbucket for the build status
[08:38:21.855] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:21.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:45:0) after 1m0s
[08:39:21.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:45:0)
[08:39:21.882] Timer tick, asking Buildbucket for the build status
[08:39:21.999] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:21.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:46:0) after 1m0s
[08:40:22.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:46:0)
[08:40:22.016] Timer tick, asking Buildbucket for the build status
[08:40:22.075] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:22.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:47:0) after 1m0s
[08:41:22.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:47:0)
[08:41:22.133] Timer tick, asking Buildbucket for the build status
[08:41:22.496] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:22.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:48:0) after 1m0s
[08:42:22.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:48:0)
[08:42:22.616] Timer tick, asking Buildbucket for the build status
[08:42:22.772] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:22.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:49:0) after 1m0s
[08:43:22.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:49:0)
[08:43:22.911] Timer tick, asking Buildbucket for the build status
[08:43:22.986] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:22.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:50:0) after 1m0s
[08:44:23.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:50:0)
[08:44:23.038] Timer tick, asking Buildbucket for the build status
[08:44:23.125] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:23.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:51:0) after 1m0s
[08:45:23.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:51:0)
[08:45:23.210] Timer tick, asking Buildbucket for the build status
[08:45:23.432] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:23.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:52:0) after 1m0s
[08:46:23.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:52:0)
[08:46:23.495] Timer tick, asking Buildbucket for the build status
[08:46:23.670] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:23.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:53:0) after 1m0s
[08:47:23.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:53:0)
[08:47:23.650] Timer tick, asking Buildbucket for the build status
[08:47:23.724] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:23.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:54:0) after 1m0s
[08:48:23.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:54:0)
[08:48:23.782] Timer tick, asking Buildbucket for the build status
[08:48:23.837] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:23.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:55:0) after 1m0s
[08:49:24.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:55:0)
[08:49:24.000] Timer tick, asking Buildbucket for the build status
[08:49:24.062] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:24.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:56:0) after 1m0s
[08:50:24.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:56:0)
[08:50:24.092] Timer tick, asking Buildbucket for the build status
[08:50:24.181] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:24.181] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:57:0) after 1m0s
[08:51:24.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:57:0)
[08:51:24.202] Timer tick, asking Buildbucket for the build status
[08:51:24.416] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:24.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:58:0) after 1m0s
[08:52:24.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:58:0)
[08:52:24.451] Timer tick, asking Buildbucket for the build status
[08:52:24.522] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:24.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:59:0) after 1m0s
[08:53:24.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:59:0)
[08:53:24.615] Timer tick, asking Buildbucket for the build status
[08:53:24.677] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:24.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:60:0) after 1m0s
[08:54:24.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:60:0)
[08:54:24.724] Timer tick, asking Buildbucket for the build status
[08:54:24.780] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:24.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:61:0) after 1m0s
[08:55:24.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:61:0)
[08:55:24.849] Timer tick, asking Buildbucket for the build status
[08:55:24.922] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:24.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:62:0) after 1m0s
[08:56:24.980] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:62:0)
[08:56:24.980] Timer tick, asking Buildbucket for the build status
[08:56:25.133] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:25.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:63:0) after 1m0s
[08:57:25.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:63:0)
[08:57:25.189] Timer tick, asking Buildbucket for the build status
[08:57:25.244] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:25.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:64:0) after 1m0s
[08:58:25.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:64:0)
[08:58:25.275] Timer tick, asking Buildbucket for the build status
[08:58:25.474] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:25.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:65:0) after 1m0s
[08:59:25.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:65:0)
[08:59:25.589] Timer tick, asking Buildbucket for the build status
[08:59:25.660] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:25.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:66:0) after 1m0s
[09:00:25.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:66:0)
[09:00:25.761] Timer tick, asking Buildbucket for the build status
[09:00:25.881] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:25.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:67:0) after 1m0s
[09:01:25.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:67:0)
[09:01:25.948] Timer tick, asking Buildbucket for the build status
[09:01:26.047] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:26.047] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:68:0) after 1m0s
[09:02:26.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:68:0)
[09:02:26.095] Timer tick, asking Buildbucket for the build status
[09:02:26.154] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:26.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:69:0) after 1m0s
[09:03:26.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:69:0)
[09:03:26.164] Timer tick, asking Buildbucket for the build status
[09:03:26.728] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:26.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:70:0) after 1m0s
[09:04:26.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:70:0)
[09:04:26.791] Timer tick, asking Buildbucket for the build status
[09:04:26.927] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:26.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:71:0) after 1m0s
[09:05:27.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:71:0)
[09:05:27.002] Timer tick, asking Buildbucket for the build status
[09:05:27.081] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:27.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:72:0) after 1m0s
[09:06:27.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:72:0)
[09:06:27.135] Timer tick, asking Buildbucket for the build status
[09:06:27.343] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:27.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:73:0) after 1m0s
[09:07:27.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:73:0)
[09:07:27.369] Timer tick, asking Buildbucket for the build status
[09:07:27.438] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:27.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:74:0) after 1m0s
[09:08:27.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:74:0)
[09:08:27.468] Timer tick, asking Buildbucket for the build status
[09:08:27.531] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:27.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:75:0) after 1m0s
[09:09:27.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:75:0)
[09:09:27.765] Timer tick, asking Buildbucket for the build status
[09:09:28.038] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:28.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:76:0) after 1m0s
[09:10:28.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:76:0)
[09:10:28.233] Timer tick, asking Buildbucket for the build status
[09:10:28.298] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:28.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:77:0) after 1m0s
[09:11:28.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:77:0)
[09:11:28.431] Timer tick, asking Buildbucket for the build status
[09:11:28.533] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:28.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:78:0) after 1m0s
[09:12:28.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:78:0)
[09:12:28.595] Timer tick, asking Buildbucket for the build status
[09:12:28.661] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:28.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:79:0) after 1m0s
[09:13:28.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:79:0)
[09:13:28.669] Timer tick, asking Buildbucket for the build status
[09:13:28.733] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:28.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:80:0) after 1m0s
[09:14:28.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:80:0)
[09:14:28.778] Timer tick, asking Buildbucket for the build status
[09:14:29.204] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:29.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:81:0) after 1m0s
[09:15:29.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:81:0)
[09:15:29.295] Timer tick, asking Buildbucket for the build status
[09:15:29.445] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:29.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:82:0) after 1m0s
[09:16:29.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:82:0)
[09:16:29.495] Timer tick, asking Buildbucket for the build status
[09:16:29.631] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:29.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:83:0) after 1m0s
[09:17:29.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:83:0)
[09:17:29.672] Timer tick, asking Buildbucket for the build status
[09:17:29.813] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:29.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:84:0) after 1m0s
[09:18:29.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:84:0)
[09:18:29.884] Timer tick, asking Buildbucket for the build status
[09:18:30.032] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:30.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:85:0) after 1m0s
[09:19:30.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:85:0)
[09:19:30.053] Timer tick, asking Buildbucket for the build status
[09:19:30.138] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:30.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:86:0) after 1m0s
[09:20:30.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:86:0)
[09:20:30.289] Timer tick, asking Buildbucket for the build status
[09:20:30.526] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:30.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:87:0) after 1m0s
[09:21:30.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:87:0)
[09:21:30.680] Timer tick, asking Buildbucket for the build status
[09:21:30.881] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:30.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:88:0) after 1m0s
[09:22:31.100] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:88:0)
[09:22:31.100] Timer tick, asking Buildbucket for the build status
[09:22:31.203] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:31.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:89:0) after 1m0s
[09:23:31.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:89:0)
[09:23:31.263] Timer tick, asking Buildbucket for the build status
[09:23:31.374] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:31.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:90:0) after 1m0s
[09:24:31.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:90:0)
[09:24:31.442] Timer tick, asking Buildbucket for the build status
[09:24:33.035] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:33.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:91:0) after 1m0s
[09:25:33.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:91:0)
[09:25:33.265] Timer tick, asking Buildbucket for the build status
[09:25:34.154] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:34.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:92:0) after 1m0s
[09:26:34.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:92:0)
[09:26:34.139] Timer tick, asking Buildbucket for the build status
[09:26:34.456] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:34.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:93:0) after 1m0s
[09:27:34.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:93:0)
[09:27:34.536] Timer tick, asking Buildbucket for the build status
[09:27:34.819] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:34.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:94:0) after 1m0s
[09:28:34.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:94:0)
[09:28:34.874] Timer tick, asking Buildbucket for the build status
[09:28:34.935] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:34.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:95:0) after 1m0s
[09:29:34.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:95:0)
[09:29:34.992] Timer tick, asking Buildbucket for the build status
[09:29:35.096] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:35.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:96:0) after 1m0s
[09:30:35.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:96:0)
[09:30:35.278] Timer tick, asking Buildbucket for the build status
[09:30:35.340] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:35.340] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:97:0) after 1m0s
[09:31:35.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:97:0)
[09:31:35.396] Timer tick, asking Buildbucket for the build status
[09:31:35.546] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:35.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:98:0) after 1m0s
[09:32:35.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:98:0)
[09:32:35.599] Timer tick, asking Buildbucket for the build status
[09:32:35.675] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:35.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:99:0) after 1m0s
[09:33:35.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:99:0)
[09:33:35.838] Timer tick, asking Buildbucket for the build status
[09:33:35.907] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:35.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:100:0) after 1m0s
[09:34:36.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:100:0)
[09:34:36.042] Timer tick, asking Buildbucket for the build status
[09:34:36.108] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:36.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:101:0) after 1m0s
[09:35:36.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:101:0)
[09:35:36.201] Timer tick, asking Buildbucket for the build status
[09:35:36.305] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:36.305] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:102:0) after 1m0s
[09:36:36.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:102:0)
[09:36:36.566] Timer tick, asking Buildbucket for the build status
[09:36:36.676] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:36.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:103:0) after 1m0s
[09:37:36.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:103:0)
[09:37:36.798] Timer tick, asking Buildbucket for the build status
[09:37:36.863] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:36.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:104:0) after 1m0s
[09:38:36.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:104:0)
[09:38:36.886] Timer tick, asking Buildbucket for the build status
[09:38:36.945] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:36.945] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:105:0) after 1m0s
[09:39:37.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:105:0)
[09:39:37.067] Timer tick, asking Buildbucket for the build status
[09:39:37.157] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:37.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:106:0) after 1m0s
[09:40:37.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:106:0)
[09:40:37.226] Timer tick, asking Buildbucket for the build status
[09:40:37.394] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:37.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:107:0) after 1m0s
[09:41:37.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:107:0)
[09:41:37.566] Timer tick, asking Buildbucket for the build status
[09:41:37.750] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:37.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:108:0) after 1m0s
[09:42:37.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:108:0)
[09:42:37.795] Timer tick, asking Buildbucket for the build status
[09:42:37.865] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:37.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:109:0) after 1m0s
[09:43:37.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:109:0)
[09:43:37.912] Timer tick, asking Buildbucket for the build status
[09:43:37.985] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:37.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:110:0) after 1m0s
[09:44:38.140] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:110:0)
[09:44:38.140] Timer tick, asking Buildbucket for the build status
[09:44:38.210] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:38.210] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:111:0) after 1m0s
[09:45:38.300] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:111:0)
[09:45:38.300] Timer tick, asking Buildbucket for the build status
[09:45:38.500] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:38.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:112:0) after 1m0s
[09:46:38.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:112:0)
[09:46:38.587] Timer tick, asking Buildbucket for the build status
[09:46:38.690] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:38.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:113:0) after 1m0s
[09:47:38.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:113:0)
[09:47:38.716] Timer tick, asking Buildbucket for the build status
[09:47:38.773] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:38.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:114:0) after 1m0s
[09:48:38.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:114:0)
[09:48:38.849] Timer tick, asking Buildbucket for the build status
[09:48:38.928] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:38.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:115:0) after 1m0s
[09:49:38.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:115:0)
[09:49:38.983] Timer tick, asking Buildbucket for the build status
[09:49:39.044] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:39.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:116:0) after 1m0s
[09:50:39.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:116:0)
[09:50:39.949] Timer tick, asking Buildbucket for the build status
[09:50:40.005] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:40.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:117:0) after 1m0s
[09:51:40.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:117:0)
[09:51:40.270] Timer tick, asking Buildbucket for the build status
[09:51:40.376] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:40.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:118:0) after 1m0s
[09:52:40.501] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:118:0)
[09:52:40.501] Timer tick, asking Buildbucket for the build status
[09:52:40.552] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:40.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:119:0) after 1m0s
[09:53:40.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:119:0)
[09:53:40.705] Timer tick, asking Buildbucket for the build status
[09:53:40.850] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:40.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:120:0) after 1m0s
[09:54:40.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:120:0)
[09:54:40.938] Timer tick, asking Buildbucket for the build status
[09:54:41.037] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:41.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:121:0) after 1m0s
[09:55:41.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:121:0)
[09:55:41.241] Timer tick, asking Buildbucket for the build status
[09:55:41.348] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:41.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:122:0) after 1m0s
[09:56:41.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:122:0)
[09:56:41.416] Timer tick, asking Buildbucket for the build status
[09:56:41.514] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:41.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:123:0) after 1m0s
[09:57:41.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:123:0)
[09:57:41.629] Timer tick, asking Buildbucket for the build status
[09:57:41.924] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:41.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:124:0) after 1m0s
[09:58:41.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:124:0)
[09:58:41.948] Timer tick, asking Buildbucket for the build status
[09:58:42.032] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:42.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:125:0) after 1m0s
[09:59:42.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:125:0)
[09:59:42.055] Timer tick, asking Buildbucket for the build status
[09:59:42.107] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:42.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:126:0) after 1m0s
[10:00:42.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:126:0)
[10:00:42.234] Timer tick, asking Buildbucket for the build status
[10:00:42.287] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:42.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:127:0) after 1m0s
[10:01:42.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:127:0)
[10:01:42.396] Timer tick, asking Buildbucket for the build status
[10:01:42.491] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:42.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:128:0) after 1m0s
[10:02:42.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:128:0)
[10:02:42.585] Timer tick, asking Buildbucket for the build status
[10:02:43.260] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:43.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:129:0) after 1m0s
[10:03:43.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:129:0)
[10:03:43.633] Timer tick, asking Buildbucket for the build status
[10:03:43.727] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:43.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:130:0) after 1m0s
[10:04:43.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:130:0)
[10:04:43.818] Timer tick, asking Buildbucket for the build status
[10:04:43.970] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:43.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:131:0) after 1m0s
[10:05:44.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:131:0)
[10:05:44.049] Timer tick, asking Buildbucket for the build status
[10:05:44.316] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:44.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:132:0) after 1m0s
[10:06:44.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:132:0)
[10:06:44.306] Timer tick, asking Buildbucket for the build status
[10:06:44.605] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:44.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:133:0) after 1m0s
[10:07:44.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:133:0)
[10:07:44.680] Timer tick, asking Buildbucket for the build status
[10:07:44.756] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:44.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:134:0) after 1m0s
[10:08:44.799] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:134:0)
[10:08:44.799] Timer tick, asking Buildbucket for the build status
[10:08:45.014] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:45.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:135:0) after 1m0s
[10:09:45.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:135:0)
[10:09:45.164] Timer tick, asking Buildbucket for the build status
[10:09:45.249] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:45.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:136:0) after 1m0s
[10:10:45.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:136:0)
[10:10:45.290] Timer tick, asking Buildbucket for the build status
[10:10:45.500] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:45.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:137:0) after 1m0s
[10:11:45.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:137:0)
[10:11:45.694] Timer tick, asking Buildbucket for the build status
[10:11:45.820] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:45.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:138:0) after 1m0s
[10:12:45.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:138:0)
[10:12:45.879] Timer tick, asking Buildbucket for the build status
[10:12:46.592] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:46.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:139:0) after 1m0s
[10:13:46.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:139:0)
[10:13:46.656] Timer tick, asking Buildbucket for the build status
[10:13:46.727] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:46.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:140:0) after 1m0s
[10:14:46.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:140:0)
[10:14:46.807] Timer tick, asking Buildbucket for the build status
[10:14:46.871] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:46.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:141:0) after 1m0s
[10:15:46.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:141:0)
[10:15:46.955] Timer tick, asking Buildbucket for the build status
[10:15:47.224] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:47.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:142:0) after 1m0s
[10:16:47.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:142:0)
[10:16:47.211] Timer tick, asking Buildbucket for the build status
[10:16:47.348] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:47.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:143:0) after 1m0s
[10:17:47.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:143:0)
[10:17:47.394] Timer tick, asking Buildbucket for the build status
[10:17:47.869] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:47.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:144:0) after 1m0s
[10:18:47.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:144:0)
[10:18:47.983] Timer tick, asking Buildbucket for the build status
[10:18:48.365] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:48.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:145:0) after 1m0s
[10:19:48.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:145:0)
[10:19:48.467] Timer tick, asking Buildbucket for the build status
[10:19:48.709] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:48.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:146:0) after 1m0s
[10:20:48.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:146:0)
[10:20:48.693] Timer tick, asking Buildbucket for the build status
[10:20:48.754] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:48.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:147:0) after 1m0s
[10:21:48.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:147:0)
[10:21:48.843] Timer tick, asking Buildbucket for the build status
[10:21:48.988] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:48.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:148:0) after 1m0s
[10:22:49.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:148:0)
[10:22:49.143] Timer tick, asking Buildbucket for the build status
[10:22:53.086] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:53.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:149:0) after 1m0s
[10:23:53.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:149:0)
[10:23:53.595] Timer tick, asking Buildbucket for the build status
[10:23:53.683] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:53.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:150:0) after 1m0s
[10:24:53.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:150:0)
[10:24:53.762] Timer tick, asking Buildbucket for the build status
[10:24:53.861] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:53.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:151:0) after 1m0s
[10:25:53.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:151:0)
[10:25:53.894] Timer tick, asking Buildbucket for the build status
[10:25:54.127] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:54.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:152:0) after 1m0s
[10:26:54.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:152:0)
[10:26:54.200] Timer tick, asking Buildbucket for the build status
[10:26:54.301] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:54.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:153:0) after 1m0s
[10:27:54.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:153:0)
[10:27:54.390] Timer tick, asking Buildbucket for the build status
[10:27:56.402] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:56.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:154:0) after 1m0s
[10:28:56.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:154:0)
[10:28:56.482] Timer tick, asking Buildbucket for the build status
[10:28:56.561] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:56.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:155:0) after 1m0s
[10:29:56.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:155:0)
[10:29:56.621] Timer tick, asking Buildbucket for the build status
[10:29:56.684] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:56.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:156:0) after 1m0s
[10:30:56.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:156:0)
[10:30:56.665] Timer tick, asking Buildbucket for the build status
[10:30:56.733] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:56.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:157:0) after 1m0s
[10:31:56.844] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:157:0)
[10:31:56.844] Timer tick, asking Buildbucket for the build status
[10:31:56.984] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:56.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:158:0) after 1m0s
[10:32:57.120] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:158:0)
[10:32:57.120] Timer tick, asking Buildbucket for the build status
[10:32:57.195] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:57.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:159:0) after 1m0s
[10:33:57.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:159:0)
[10:33:57.210] Timer tick, asking Buildbucket for the build status
[10:33:57.269] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:57.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:160:0) after 1m0s
[10:34:57.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:160:0)
[10:34:57.298] Timer tick, asking Buildbucket for the build status
[10:34:57.394] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:57.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:161:0) after 1m0s
[10:35:57.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:161:0)
[10:35:57.490] Timer tick, asking Buildbucket for the build status
[10:35:57.769] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:57.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:162:0) after 1m0s
[10:36:57.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:162:0)
[10:36:57.810] Timer tick, asking Buildbucket for the build status
[10:36:57.936] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:57.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:163:0) after 1m0s
[10:37:57.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:163:0)
[10:37:57.992] Timer tick, asking Buildbucket for the build status
[10:37:58.091] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:58.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:164:0) after 1m0s
[10:38:58.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:164:0)
[10:38:58.236] Timer tick, asking Buildbucket for the build status
[10:38:58.302] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:58.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:165:0) after 1m0s
[10:39:58.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:165:0)
[10:39:58.390] Timer tick, asking Buildbucket for the build status
[10:39:58.455] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:58.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:166:0) after 1m0s
[10:40:58.501] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:166:0)
[10:40:58.501] Timer tick, asking Buildbucket for the build status
[10:40:58.577] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:58.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:167:0) after 1m0s
[10:41:58.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:167:0)
[10:41:58.565] Timer tick, asking Buildbucket for the build status
[10:41:58.650] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:58.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:168:0) after 1m0s
[10:42:58.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:168:0)
[10:42:58.720] Timer tick, asking Buildbucket for the build status
[10:43:01.205] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:01.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:169:0) after 1m0s
[10:44:01.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:169:0)
[10:44:01.496] Timer tick, asking Buildbucket for the build status
[10:44:01.567] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:01.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:170:0) after 1m0s
[10:45:02.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:170:0)
[10:45:02.272] Timer tick, asking Buildbucket for the build status
[10:45:02.588] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:02.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:171:0) after 1m0s
[10:46:02.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:171:0)
[10:46:02.786] Timer tick, asking Buildbucket for the build status
[10:46:02.860] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:02.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:172:0) after 1m0s
[10:47:03.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:172:0)
[10:47:03.085] Timer tick, asking Buildbucket for the build status
[10:47:03.181] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:03.181] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:173:0) after 1m0s
[10:48:03.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:173:0)
[10:48:03.481] Timer tick, asking Buildbucket for the build status
[10:48:03.537] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:03.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:174:0) after 1m0s
[10:49:03.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:174:0)
[10:49:03.644] Timer tick, asking Buildbucket for the build status
[10:49:03.709] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:03.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:175:0) after 1m0s
[10:50:03.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:175:0)
[10:50:03.762] Timer tick, asking Buildbucket for the build status
[10:50:03.862] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:03.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:176:0) after 1m0s
[10:51:04.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:176:0)
[10:51:04.088] Timer tick, asking Buildbucket for the build status
[10:51:04.160] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:04.160] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:177:0) after 1m0s
[10:52:04.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:177:0)
[10:52:04.311] Timer tick, asking Buildbucket for the build status
[10:52:04.618] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:04.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:178:0) after 1m0s
[10:53:04.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:178:0)
[10:53:04.674] Timer tick, asking Buildbucket for the build status
[10:53:04.762] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:04.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:179:0) after 1m0s
[10:54:04.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:179:0)
[10:54:04.968] Timer tick, asking Buildbucket for the build status
[10:54:05.036] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:05.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:180:0) after 1m0s
[10:55:05.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:180:0)
[10:55:05.157] Timer tick, asking Buildbucket for the build status
[10:55:05.487] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:05.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:181:0) after 1m0s
[10:56:05.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:181:0)
[10:56:05.569] Timer tick, asking Buildbucket for the build status
[10:56:05.672] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:05.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:182:0) after 1m0s
[10:57:05.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:182:0)
[10:57:05.724] Timer tick, asking Buildbucket for the build status
[10:57:05.837] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:05.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:183:0) after 1m0s
[10:58:05.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:183:0)
[10:58:05.960] Timer tick, asking Buildbucket for the build status
[10:58:06.200] Build 8861497796641216192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:06.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026927858714781952:184:0) after 1m0s
[10:58:20.670] Received PubSub notification, asking Buildbucket for the build status
[10:58:20.732] Build 8861497796641216192: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:58:20.732] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1607425099813316",
    "created_by": "project:infra",
    "created_ts": "1607414168660689",
    "id": "8861497796641216192",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"89.0.4348.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"759f076d-92e8-44a4-a36c-a26266564e7e\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"89.0.4348.3\"}}",
    "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-knos\"], \"image\": [\"chrome-xenial-20120600-c5cfbe11ce8\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1607414224140300",
    "status": "COMPLETED",
    "status_changed_ts": "1607425100222749",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9026927858714781952",
      "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/8861497796641216192/+/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:505a2b50a4fbbf10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1607425100235145",
    "url": "https://ci.chromium.org/b/8861497796641216192",
    "utcnow_ts": "1607425100725480"
  }
}
[10:58:20.733] Invocation finished in 3h2m13.433971706s with status SUCCEEDED