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

• parent_buildername:publish_tarball
• user_agent:recipe

[22:50:31.122] New invocation is queued and will start shortly
[22:50:31.122] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[22:50:32.385] Starting the invocation (attempt 1)
[22:50:32.445] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:50:32.445] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:50:32.446] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9028592930500530192",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"89.0.4330.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"f12448e3-c7fa-4df8-929b-4f96928602cb\",\"title\":\"publish_tarball/0\"}]},\"version\":\"89.0.4330.2\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9028592930500530192",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[22:50:33.737] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1605826232717347",
    "id": "8863162868160879280",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"89.0.4330.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f12448e3-c7fa-4df8-929b-4f96928602cb\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"89.0.4330.2\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1605826233349563",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9028592930500530192",
      "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/8863162868160879280/+/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": "1605826233349735",
    "url": "https://ci.chromium.org/b/8863162868160879280",
    "utcnow_ts": "1605826233723367"
  }
}
[22:50:33.737] Task URL: https://ci.chromium.org/b/8863162868160879280
[22:50:33.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:2:0) after 1m0s
[22:50:41.501] Received PubSub notification, asking Buildbucket for the build status
[22:50:41.803] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:33.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:2:0)
[22:51:33.843] Timer tick, asking Buildbucket for the build status
[22:51:34.120] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:34.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:4:0) after 1m0s
[22:52:34.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:4:0)
[22:52:34.167] Timer tick, asking Buildbucket for the build status
[22:52:34.487] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:34.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:5:0) after 1m0s
[22:53:34.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:5:0)
[22:53:34.536] Timer tick, asking Buildbucket for the build status
[22:53:35.297] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:35.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:6:0) after 1m0s
[22:54:35.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:6:0)
[22:54:35.327] Timer tick, asking Buildbucket for the build status
[22:54:35.403] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:35.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:7:0) after 1m0s
[22:55:35.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:7:0)
[22:55:35.426] Timer tick, asking Buildbucket for the build status
[22:55:35.695] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:35.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:8:0) after 1m0s
[22:56:35.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:8:0)
[22:56:35.796] Timer tick, asking Buildbucket for the build status
[22:56:35.908] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:35.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:9:0) after 1m0s
[22:57:35.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:9:0)
[22:57:35.968] Timer tick, asking Buildbucket for the build status
[22:57:36.141] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:36.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:10:0) after 1m0s
[22:58:36.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:10:0)
[22:58:36.270] Timer tick, asking Buildbucket for the build status
[22:58:36.511] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:36.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:11:0) after 1m0s
[22:59:36.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:11:0)
[22:59:36.546] Timer tick, asking Buildbucket for the build status
[22:59:36.653] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:36.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:12:0) after 1m0s
[23:00:36.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:12:0)
[23:00:36.749] Timer tick, asking Buildbucket for the build status
[23:00:37.363] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:37.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:13:0) after 1m0s
[23:01:37.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:13:0)
[23:01:37.363] Timer tick, asking Buildbucket for the build status
[23:01:37.446] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:37.446] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:14:0) after 1m0s
[23:02:37.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:14:0)
[23:02:37.469] Timer tick, asking Buildbucket for the build status
[23:02:37.611] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:37.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:15:0) after 1m0s
[23:03:37.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:15:0)
[23:03:37.747] Timer tick, asking Buildbucket for the build status
[23:03:37.847] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:37.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:16:0) after 1m0s
[23:04:37.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:16:0)
[23:04:37.929] Timer tick, asking Buildbucket for the build status
[23:04:38.022] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:38.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:17:0) after 1m0s
[23:05:38.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:17:0)
[23:05:38.134] Timer tick, asking Buildbucket for the build status
[23:05:39.604] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:39.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:18:0) after 1m0s
[23:06:39.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:18:0)
[23:06:39.635] Timer tick, asking Buildbucket for the build status
[23:06:39.726] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:39.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:19:0) after 1m0s
[23:07:39.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:19:0)
[23:07:39.797] Timer tick, asking Buildbucket for the build status
[23:07:39.878] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:39.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:20:0) after 1m0s
[23:08:39.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:20:0)
[23:08:39.925] Timer tick, asking Buildbucket for the build status
[23:08:40.026] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:40.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:21:0) after 1m0s
[23:09:40.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:21:0)
[23:09:40.083] Timer tick, asking Buildbucket for the build status
[23:09:40.234] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:40.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:22:0) after 1m0s
[23:10:40.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:22:0)
[23:10:40.238] Timer tick, asking Buildbucket for the build status
[23:10:40.416] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:40.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:23:0) after 1m0s
[23:11:40.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:23:0)
[23:11:40.396] Timer tick, asking Buildbucket for the build status
[23:11:40.721] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:40.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:24:0) after 1m0s
[23:12:40.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:24:0)
[23:12:40.776] Timer tick, asking Buildbucket for the build status
[23:12:40.989] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:40.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:25:0) after 1m0s
[23:13:41.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:25:0)
[23:13:41.074] Timer tick, asking Buildbucket for the build status
[23:13:41.148] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:41.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:26:0) after 1m0s
[23:14:41.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:26:0)
[23:14:41.187] Timer tick, asking Buildbucket for the build status
[23:14:41.259] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:41.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:27:0) after 1m0s
[23:15:41.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:27:0)
[23:15:41.303] Timer tick, asking Buildbucket for the build status
[23:15:41.641] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:41.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:28:0) after 1m0s
[23:16:41.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:28:0)
[23:16:41.690] Timer tick, asking Buildbucket for the build status
[23:16:41.804] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:41.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:29:0) after 1m0s
[23:17:41.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:29:0)
[23:17:41.885] Timer tick, asking Buildbucket for the build status
[23:17:42.014] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:42.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:30:0) after 1m0s
[23:18:42.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:30:0)
[23:18:42.085] Timer tick, asking Buildbucket for the build status
[23:18:42.160] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:42.160] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:31:0) after 1m0s
[23:19:42.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:31:0)
[23:19:42.370] Timer tick, asking Buildbucket for the build status
[23:19:42.656] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:42.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:32:0) after 1m0s
[23:20:42.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:32:0)
[23:20:42.749] Timer tick, asking Buildbucket for the build status
[23:20:43.353] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:43.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:33:0) after 1m0s
[23:21:43.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:33:0)
[23:21:43.635] Timer tick, asking Buildbucket for the build status
[23:21:43.721] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:43.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:34:0) after 1m0s
[23:22:43.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:34:0)
[23:22:43.777] Timer tick, asking Buildbucket for the build status
[23:22:43.853] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:43.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:35:0) after 1m0s
[23:23:43.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:35:0)
[23:23:43.904] Timer tick, asking Buildbucket for the build status
[23:23:43.989] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:43.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:36:0) after 1m0s
[23:24:43.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:36:0)
[23:24:43.973] Timer tick, asking Buildbucket for the build status
[23:24:44.310] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:44.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:37:0) after 1m0s
[23:25:44.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:37:0)
[23:25:44.523] Timer tick, asking Buildbucket for the build status
[23:25:44.632] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:44.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:38:0) after 1m0s
[23:26:44.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:38:0)
[23:26:44.783] Timer tick, asking Buildbucket for the build status
[23:26:44.962] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:44.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:39:0) after 1m0s
[23:27:45.170] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:39:0)
[23:27:45.170] Timer tick, asking Buildbucket for the build status
[23:27:45.351] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:45.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:40:0) after 1m0s
[23:28:45.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:40:0)
[23:28:45.516] Timer tick, asking Buildbucket for the build status
[23:28:45.628] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:45.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:41:0) after 1m0s
[23:29:45.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:41:0)
[23:29:45.635] Timer tick, asking Buildbucket for the build status
[23:29:45.701] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:45.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:42:0) after 1m0s
[23:30:45.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:42:0)
[23:30:45.773] Timer tick, asking Buildbucket for the build status
[23:30:45.886] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:45.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:43:0) after 1m0s
[23:31:46.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:43:0)
[23:31:46.087] Timer tick, asking Buildbucket for the build status
[23:31:46.155] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:46.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:44:0) after 1m0s
[23:32:46.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:44:0)
[23:32:46.231] Timer tick, asking Buildbucket for the build status
[23:32:46.302] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:46.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:45:0) after 1m0s
[23:33:46.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:45:0)
[23:33:46.522] Timer tick, asking Buildbucket for the build status
[23:33:46.585] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:46.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:46:0) after 1m0s
[23:34:46.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:46:0)
[23:34:46.785] Timer tick, asking Buildbucket for the build status
[23:34:46.950] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:46.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:47:0) after 1m0s
[23:35:47.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:47:0)
[23:35:47.017] Timer tick, asking Buildbucket for the build status
[23:35:47.145] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:47.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:48:0) after 1m0s
[23:36:47.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:48:0)
[23:36:47.394] Timer tick, asking Buildbucket for the build status
[23:36:47.518] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:47.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:49:0) after 1m0s
[23:37:47.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:49:0)
[23:37:47.609] Timer tick, asking Buildbucket for the build status
[23:37:47.670] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:47.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:50:0) after 1m0s
[23:38:47.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:50:0)
[23:38:47.747] Timer tick, asking Buildbucket for the build status
[23:38:47.809] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:47.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:51:0) after 1m0s
[23:39:47.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:51:0)
[23:39:47.967] Timer tick, asking Buildbucket for the build status
[23:39:48.840] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:48.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:52:0) after 1m0s
[23:40:48.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:52:0)
[23:40:48.882] Timer tick, asking Buildbucket for the build status
[23:40:49.022] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:49.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:53:0) after 1m0s
[23:41:49.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:53:0)
[23:41:49.135] Timer tick, asking Buildbucket for the build status
[23:41:49.247] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:49.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:54:0) after 1m0s
[23:42:49.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:54:0)
[23:42:49.316] Timer tick, asking Buildbucket for the build status
[23:42:49.476] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:49.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:55:0) after 1m0s
[23:43:49.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:55:0)
[23:43:49.554] Timer tick, asking Buildbucket for the build status
[23:43:49.610] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:49.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:56:0) after 1m0s
[23:44:49.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:56:0)
[23:44:49.703] Timer tick, asking Buildbucket for the build status
[23:44:49.781] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:49.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:57:0) after 1m0s
[23:45:49.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:57:0)
[23:45:49.919] Timer tick, asking Buildbucket for the build status
[23:45:50.187] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:50.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:58:0) after 1m0s
[23:46:50.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:58:0)
[23:46:50.277] Timer tick, asking Buildbucket for the build status
[23:46:51.698] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:51.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:59:0) after 1m0s
[23:47:51.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:59:0)
[23:47:51.756] Timer tick, asking Buildbucket for the build status
[23:47:52.032] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:52.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:60:0) after 1m0s
[23:48:52.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:60:0)
[23:48:52.124] Timer tick, asking Buildbucket for the build status
[23:48:52.182] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:52.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:61:0) after 1m0s
[23:49:52.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:61:0)
[23:49:52.203] Timer tick, asking Buildbucket for the build status
[23:49:52.274] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:52.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:62:0) after 1m0s
[23:50:52.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:62:0)
[23:50:52.336] Timer tick, asking Buildbucket for the build status
[23:50:52.434] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:52.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:63:0) after 1m0s
[23:51:52.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:63:0)
[23:51:52.619] Timer tick, asking Buildbucket for the build status
[23:51:52.688] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:52.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:64:0) after 1m0s
[23:52:52.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:64:0)
[23:52:52.809] Timer tick, asking Buildbucket for the build status
[23:52:53.415] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:53.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:65:0) after 1m0s
[23:53:53.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:65:0)
[23:53:53.469] Timer tick, asking Buildbucket for the build status
[23:53:53.689] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:53.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:66:0) after 1m0s
[23:54:53.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:66:0)
[23:54:53.765] Timer tick, asking Buildbucket for the build status
[23:54:53.846] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:53.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:67:0) after 1m0s
[23:55:54.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:67:0)
[23:55:54.025] Timer tick, asking Buildbucket for the build status
[23:55:54.153] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:54.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:68:0) after 1m0s
[23:56:54.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:68:0)
[23:56:54.240] Timer tick, asking Buildbucket for the build status
[23:56:54.315] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:54.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:69:0) after 1m0s
[23:57:54.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:69:0)
[23:57:54.397] Timer tick, asking Buildbucket for the build status
[23:57:54.538] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:54.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:70:0) after 1m0s
[23:58:54.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:70:0)
[23:58:54.625] Timer tick, asking Buildbucket for the build status
[23:58:55.217] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:55.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:71:0) after 1m0s
[23:59:55.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:71:0)
[23:59:55.291] Timer tick, asking Buildbucket for the build status
[23:59:55.452] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:55.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:72:0) after 1m0s
[00:00:55.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:72:0)
[00:00:55.503] Timer tick, asking Buildbucket for the build status
[00:00:55.636] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:55.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:73:0) after 1m0s
[00:01:55.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:73:0)
[00:01:55.675] Timer tick, asking Buildbucket for the build status
[00:01:55.736] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:55.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:74:0) after 1m0s
[00:02:55.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:74:0)
[00:02:55.825] Timer tick, asking Buildbucket for the build status
[00:02:55.899] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:55.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:75:0) after 1m0s
[00:03:56.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:75:0)
[00:03:56.103] Timer tick, asking Buildbucket for the build status
[00:03:56.175] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:56.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:76:0) after 1m0s
[00:04:56.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:76:0)
[00:04:56.270] Timer tick, asking Buildbucket for the build status
[00:04:56.395] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:56.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:77:0) after 1m0s
[00:05:56.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:77:0)
[00:05:56.444] Timer tick, asking Buildbucket for the build status
[00:05:56.878] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:56.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:78:0) after 1m0s
[00:06:56.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:78:0)
[00:06:56.920] Timer tick, asking Buildbucket for the build status
[00:06:56.989] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:56.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:79:0) after 1m0s
[00:07:57.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:79:0)
[00:07:57.047] Timer tick, asking Buildbucket for the build status
[00:07:57.279] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:57.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:80:0) after 1m0s
[00:08:57.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:80:0)
[00:08:57.361] Timer tick, asking Buildbucket for the build status
[00:08:57.421] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:57.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:81:0) after 1m0s
[00:09:57.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:81:0)
[00:09:57.544] Timer tick, asking Buildbucket for the build status
[00:09:57.612] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:57.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:82:0) after 1m0s
[00:10:57.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:82:0)
[00:10:57.696] Timer tick, asking Buildbucket for the build status
[00:10:57.853] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:57.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:83:0) after 1m0s
[00:11:57.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:83:0)
[00:11:57.860] Timer tick, asking Buildbucket for the build status
[00:11:58.142] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:58.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:84:0) after 1m0s
[00:12:58.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:84:0)
[00:12:58.172] Timer tick, asking Buildbucket for the build status
[00:12:58.246] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:58.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:85:0) after 1m0s
[00:13:58.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:85:0)
[00:13:58.278] Timer tick, asking Buildbucket for the build status
[00:13:58.547] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:58.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:86:0) after 1m0s
[00:14:58.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:86:0)
[00:14:58.568] Timer tick, asking Buildbucket for the build status
[00:14:58.929] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:58.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:87:0) after 1m0s
[00:15:59.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:87:0)
[00:15:59.005] Timer tick, asking Buildbucket for the build status
[00:15:59.379] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:59.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:88:0) after 1m0s
[00:16:59.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:88:0)
[00:16:59.447] Timer tick, asking Buildbucket for the build status
[00:16:59.656] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:59.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:89:0) after 1m0s
[00:17:59.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:89:0)
[00:17:59.700] Timer tick, asking Buildbucket for the build status
[00:17:59.781] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:59.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:90:0) after 1m0s
[00:18:59.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:90:0)
[00:18:59.900] Timer tick, asking Buildbucket for the build status
[00:18:59.964] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:59.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:91:0) after 1m0s
[00:20:00.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:91:0)
[00:20:00.047] Timer tick, asking Buildbucket for the build status
[00:20:00.396] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:00.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:92:0) after 1m0s
[00:21:00.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:92:0)
[00:21:00.506] Timer tick, asking Buildbucket for the build status
[00:21:01.055] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:01.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:93:0) after 1m0s
[00:22:01.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:93:0)
[00:22:01.281] Timer tick, asking Buildbucket for the build status
[00:22:01.409] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:01.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:94:0) after 1m0s
[00:23:01.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:94:0)
[00:23:01.464] Timer tick, asking Buildbucket for the build status
[00:23:02.029] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:02.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:95:0) after 1m0s
[00:24:02.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:95:0)
[00:24:02.096] Timer tick, asking Buildbucket for the build status
[00:24:02.241] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:02.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:96:0) after 1m0s
[00:25:02.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:96:0)
[00:25:02.377] Timer tick, asking Buildbucket for the build status
[00:25:02.856] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:02.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:97:0) after 1m0s
[00:26:02.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:97:0)
[00:26:02.907] Timer tick, asking Buildbucket for the build status
[00:26:03.065] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:03.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:98:0) after 1m0s
[00:27:03.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:98:0)
[00:27:03.089] Timer tick, asking Buildbucket for the build status
[00:27:03.167] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:03.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:99:0) after 1m0s
[00:28:03.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:99:0)
[00:28:03.209] Timer tick, asking Buildbucket for the build status
[00:28:03.405] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:03.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:100:0) after 1m0s
[00:29:03.509] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:100:0)
[00:29:03.509] Timer tick, asking Buildbucket for the build status
[00:29:03.636] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:03.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:101:0) after 1m0s
[00:30:03.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:101:0)
[00:30:03.701] Timer tick, asking Buildbucket for the build status
[00:30:03.811] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:03.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:102:0) after 1m0s
[00:31:03.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:102:0)
[00:31:03.979] Timer tick, asking Buildbucket for the build status
[00:31:04.110] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:04.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:103:0) after 1m0s
[00:32:04.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:103:0)
[00:32:04.186] Timer tick, asking Buildbucket for the build status
[00:32:04.301] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:04.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:104:0) after 1m0s
[00:33:04.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:104:0)
[00:33:04.435] Timer tick, asking Buildbucket for the build status
[00:33:04.504] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:04.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:105:0) after 1m0s
[00:34:04.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:105:0)
[00:34:04.655] Timer tick, asking Buildbucket for the build status
[00:34:04.948] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:04.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:106:0) after 1m0s
[00:35:05.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:106:0)
[00:35:05.247] Timer tick, asking Buildbucket for the build status
[00:35:05.328] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:05.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:107:0) after 1m0s
[00:36:05.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:107:0)
[00:36:05.460] Timer tick, asking Buildbucket for the build status
[00:36:07.336] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:07.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:108:0) after 1m0s
[00:37:07.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:108:0)
[00:37:07.434] Timer tick, asking Buildbucket for the build status
[00:37:07.508] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:07.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:109:0) after 1m0s
[00:38:07.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:109:0)
[00:38:07.632] Timer tick, asking Buildbucket for the build status
[00:38:07.696] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:07.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:110:0) after 1m0s
[00:39:07.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:110:0)
[00:39:07.785] Timer tick, asking Buildbucket for the build status
[00:39:08.248] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:08.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:111:0) after 1m0s
[00:40:08.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:111:0)
[00:40:08.341] Timer tick, asking Buildbucket for the build status
[00:40:08.430] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:08.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:112:0) after 1m0s
[00:41:08.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:112:0)
[00:41:08.485] Timer tick, asking Buildbucket for the build status
[00:41:08.725] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:08.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:113:0) after 1m0s
[00:42:08.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:113:0)
[00:42:08.774] Timer tick, asking Buildbucket for the build status
[00:42:08.907] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:08.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:114:0) after 1m0s
[00:43:08.944] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:114:0)
[00:43:08.944] Timer tick, asking Buildbucket for the build status
[00:43:09.002] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:09.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:115:0) after 1m0s
[00:44:09.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:115:0)
[00:44:09.017] Timer tick, asking Buildbucket for the build status
[00:44:09.200] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:09.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:116:0) after 1m0s
[00:45:09.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:116:0)
[00:45:09.281] Timer tick, asking Buildbucket for the build status
[00:45:09.353] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:09.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:117:0) after 1m0s
[00:46:09.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:117:0)
[00:46:09.532] Timer tick, asking Buildbucket for the build status
[00:46:09.726] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:09.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:118:0) after 1m0s
[00:47:09.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:118:0)
[00:47:09.824] Timer tick, asking Buildbucket for the build status
[00:47:09.879] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:09.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:119:0) after 1m0s
[00:48:09.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:119:0)
[00:48:09.969] Timer tick, asking Buildbucket for the build status
[00:48:10.043] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:10.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:120:0) after 1m0s
[00:49:10.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:120:0)
[00:49:10.123] Timer tick, asking Buildbucket for the build status
[00:49:10.301] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:10.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:121:0) after 1m0s
[00:50:10.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:121:0)
[00:50:10.328] Timer tick, asking Buildbucket for the build status
[00:50:10.406] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:10.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:122:0) after 1m0s
[00:51:10.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:122:0)
[00:51:10.493] Timer tick, asking Buildbucket for the build status
[00:51:10.699] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:10.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:123:0) after 1m0s
[00:52:10.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:123:0)
[00:52:10.801] Timer tick, asking Buildbucket for the build status
[00:52:10.856] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:10.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:124:0) after 1m0s
[00:53:10.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:124:0)
[00:53:10.886] Timer tick, asking Buildbucket for the build status
[00:53:10.993] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:10.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:125:0) after 1m0s
[00:54:11.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:125:0)
[00:54:11.008] Timer tick, asking Buildbucket for the build status
[00:54:11.135] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:11.135] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:126:0) after 1m0s
[00:55:11.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:126:0)
[00:55:11.230] Timer tick, asking Buildbucket for the build status
[00:55:11.531] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:11.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:127:0) after 1m0s
[00:56:11.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:127:0)
[00:56:11.658] Timer tick, asking Buildbucket for the build status
[00:56:11.772] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:11.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:128:0) after 1m0s
[00:57:11.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:128:0)
[00:57:11.950] Timer tick, asking Buildbucket for the build status
[00:57:12.041] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:12.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:129:0) after 1m0s
[00:58:12.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:129:0)
[00:58:12.196] Timer tick, asking Buildbucket for the build status
[00:58:12.405] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:12.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:130:0) after 1m0s
[00:59:12.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:130:0)
[00:59:12.407] Timer tick, asking Buildbucket for the build status
[00:59:12.519] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:12.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:131:0) after 1m0s
[01:00:12.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:131:0)
[01:00:12.607] Timer tick, asking Buildbucket for the build status
[01:00:13.348] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:13.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:132:0) after 1m0s
[01:01:13.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:132:0)
[01:01:13.422] Timer tick, asking Buildbucket for the build status
[01:01:13.543] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:13.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:133:0) after 1m0s
[01:02:13.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:133:0)
[01:02:13.574] Timer tick, asking Buildbucket for the build status
[01:02:14.583] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:14.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:134:0) after 1m0s
[01:03:14.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:134:0)
[01:03:14.655] Timer tick, asking Buildbucket for the build status
[01:03:14.867] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:14.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:135:0) after 1m0s
[01:04:14.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:135:0)
[01:04:14.953] Timer tick, asking Buildbucket for the build status
[01:04:16.014] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:16.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:136:0) after 1m0s
[01:05:16.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:136:0)
[01:05:16.067] Timer tick, asking Buildbucket for the build status
[01:05:16.383] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:16.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:137:0) after 1m0s
[01:06:16.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:137:0)
[01:06:16.449] Timer tick, asking Buildbucket for the build status
[01:06:16.573] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:16.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:138:0) after 1m0s
[01:07:16.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:138:0)
[01:07:16.619] Timer tick, asking Buildbucket for the build status
[01:07:16.949] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:16.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:139:0) after 1m0s
[01:08:16.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:139:0)
[01:08:16.997] Timer tick, asking Buildbucket for the build status
[01:08:17.083] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:17.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:140:0) after 1m0s
[01:09:17.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:140:0)
[01:09:17.142] Timer tick, asking Buildbucket for the build status
[01:09:17.518] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:17.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:141:0) after 1m0s
[01:10:17.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:141:0)
[01:10:17.686] Timer tick, asking Buildbucket for the build status
[01:10:17.783] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:17.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:142:0) after 1m0s
[01:11:17.855] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:142:0)
[01:11:17.855] Timer tick, asking Buildbucket for the build status
[01:11:18.166] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:18.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:143:0) after 1m0s
[01:12:18.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:143:0)
[01:12:18.428] Timer tick, asking Buildbucket for the build status
[01:12:19.166] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:19.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:144:0) after 1m0s
[01:13:19.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:144:0)
[01:13:19.417] Timer tick, asking Buildbucket for the build status
[01:13:19.604] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:19.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:145:0) after 1m0s
[01:14:19.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:145:0)
[01:14:19.717] Timer tick, asking Buildbucket for the build status
[01:14:19.799] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:19.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:146:0) after 1m0s
[01:15:20.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:146:0)
[01:15:20.317] Timer tick, asking Buildbucket for the build status
[01:15:20.403] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:20.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:147:0) after 1m0s
[01:16:20.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:147:0)
[01:16:20.449] Timer tick, asking Buildbucket for the build status
[01:16:20.634] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:20.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:148:0) after 1m0s
[01:17:20.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:148:0)
[01:17:20.899] Timer tick, asking Buildbucket for the build status
[01:17:20.962] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:20.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:149:0) after 1m0s
[01:18:20.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:149:0)
[01:18:20.971] Timer tick, asking Buildbucket for the build status
[01:18:21.048] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:21.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:150:0) after 1m0s
[01:19:21.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:150:0)
[01:19:21.202] Timer tick, asking Buildbucket for the build status
[01:19:21.543] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:21.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:151:0) after 1m0s
[01:20:21.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:151:0)
[01:20:21.717] Timer tick, asking Buildbucket for the build status
[01:20:21.963] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:21.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:152:0) after 1m0s
[01:21:22.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:152:0)
[01:21:22.108] Timer tick, asking Buildbucket for the build status
[01:21:22.592] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:22.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:153:0) after 1m0s
[01:22:22.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:153:0)
[01:22:22.705] Timer tick, asking Buildbucket for the build status
[01:22:22.789] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:22.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:154:0) after 1m0s
[01:23:22.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:154:0)
[01:23:22.824] Timer tick, asking Buildbucket for the build status
[01:23:22.896] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:22.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:155:0) after 1m0s
[01:24:22.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:155:0)
[01:24:22.976] Timer tick, asking Buildbucket for the build status
[01:24:23.179] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:23.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:156:0) after 1m0s
[01:25:23.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:156:0)
[01:25:23.342] Timer tick, asking Buildbucket for the build status
[01:25:23.732] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:23.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:157:0) after 1m0s
[01:26:23.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:157:0)
[01:26:23.856] Timer tick, asking Buildbucket for the build status
[01:26:24.054] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:24.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:158:0) after 1m0s
[01:27:24.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:158:0)
[01:27:24.103] Timer tick, asking Buildbucket for the build status
[01:27:24.321] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:24.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:159:0) after 1m0s
[01:28:24.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:159:0)
[01:28:24.331] Timer tick, asking Buildbucket for the build status
[01:28:24.573] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:24.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:160:0) after 1m0s
[01:29:24.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:160:0)
[01:29:24.613] Timer tick, asking Buildbucket for the build status
[01:29:24.939] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:24.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:161:0) after 1m0s
[01:30:25.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:161:0)
[01:30:25.142] Timer tick, asking Buildbucket for the build status
[01:30:25.579] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:25.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:162:0) after 1m0s
[01:31:25.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:162:0)
[01:31:25.570] Timer tick, asking Buildbucket for the build status
[01:31:25.681] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:25.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:163:0) after 1m0s
[01:32:25.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:163:0)
[01:32:25.674] Timer tick, asking Buildbucket for the build status
[01:32:25.746] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:25.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:164:0) after 1m0s
[01:33:26.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:164:0)
[01:33:26.156] Timer tick, asking Buildbucket for the build status
[01:33:26.502] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:26.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:165:0) after 1m0s
[01:34:26.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:165:0)
[01:34:26.581] Timer tick, asking Buildbucket for the build status
[01:34:26.915] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:26.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:166:0) after 1m0s
[01:35:26.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:166:0)
[01:35:26.957] Timer tick, asking Buildbucket for the build status
[01:35:27.182] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:27.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:167:0) after 1m0s
[01:36:27.260] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:167:0)
[01:36:27.260] Timer tick, asking Buildbucket for the build status
[01:36:29.041] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:29.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:168:0) after 1m0s
[01:37:29.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:168:0)
[01:37:29.145] Timer tick, asking Buildbucket for the build status
[01:37:29.308] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:29.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:169:0) after 1m0s
[01:38:29.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:169:0)
[01:38:29.404] Timer tick, asking Buildbucket for the build status
[01:38:29.484] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:29.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:170:0) after 1m0s
[01:39:29.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:170:0)
[01:39:29.584] Timer tick, asking Buildbucket for the build status
[01:39:29.688] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:29.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:171:0) after 1m0s
[01:40:29.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:171:0)
[01:40:29.798] Timer tick, asking Buildbucket for the build status
[01:40:30.131] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:30.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:172:0) after 1m0s
[01:41:30.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:172:0)
[01:41:30.247] Timer tick, asking Buildbucket for the build status
[01:41:30.650] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:30.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:173:0) after 1m0s
[01:42:30.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:173:0)
[01:42:30.721] Timer tick, asking Buildbucket for the build status
[01:42:30.774] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:30.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:174:0) after 1m0s
[01:43:30.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:174:0)
[01:43:30.796] Timer tick, asking Buildbucket for the build status
[01:43:30.915] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:30.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:175:0) after 1m0s
[01:44:31.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:175:0)
[01:44:31.001] Timer tick, asking Buildbucket for the build status
[01:44:31.148] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:31.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:176:0) after 1m0s
[01:45:31.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:176:0)
[01:45:31.204] Timer tick, asking Buildbucket for the build status
[01:45:31.318] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:31.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:177:0) after 1m0s
[01:46:31.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:177:0)
[01:46:31.398] Timer tick, asking Buildbucket for the build status
[01:46:31.645] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:31.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:178:0) after 1m0s
[01:47:31.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:178:0)
[01:47:31.713] Timer tick, asking Buildbucket for the build status
[01:47:31.774] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:31.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:179:0) after 1m0s
[01:48:32.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:179:0)
[01:48:32.135] Timer tick, asking Buildbucket for the build status
[01:48:32.247] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:32.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:180:0) after 1m0s
[01:49:32.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:180:0)
[01:49:32.466] Timer tick, asking Buildbucket for the build status
[01:49:32.528] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:32.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:181:0) after 1m0s
[01:50:32.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:181:0)
[01:50:32.595] Timer tick, asking Buildbucket for the build status
[01:50:32.669] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:32.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:182:0) after 1m0s
[01:51:32.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:182:0)
[01:51:32.698] Timer tick, asking Buildbucket for the build status
[01:51:33.118] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:33.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:183:0) after 1m0s
[01:52:33.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:183:0)
[01:52:33.166] Timer tick, asking Buildbucket for the build status
[01:52:33.230] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:33.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:184:0) after 1m0s
[01:53:33.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:184:0)
[01:53:33.258] Timer tick, asking Buildbucket for the build status
[01:53:33.320] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:33.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:185:0) after 1m0s
[01:54:33.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:185:0)
[01:54:33.397] Timer tick, asking Buildbucket for the build status
[01:54:33.509] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:33.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:186:0) after 1m0s
[01:55:33.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:186:0)
[01:55:33.534] Timer tick, asking Buildbucket for the build status
[01:55:33.598] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:33.598] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:187:0) after 1m0s
[01:56:33.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:187:0)
[01:56:33.672] Timer tick, asking Buildbucket for the build status
[01:56:33.846] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:33.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:188:0) after 1m0s
[01:57:33.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:188:0)
[01:57:33.894] Timer tick, asking Buildbucket for the build status
[01:57:33.991] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:33.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:189:0) after 1m0s
[01:58:34.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:189:0)
[01:58:34.089] Timer tick, asking Buildbucket for the build status
[01:58:34.239] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:34.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:190:0) after 1m0s
[01:59:34.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:190:0)
[01:59:34.465] Timer tick, asking Buildbucket for the build status
[01:59:34.709] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:34.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:191:0) after 1m0s
[02:00:34.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:191:0)
[02:00:34.851] Timer tick, asking Buildbucket for the build status
[02:00:34.945] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:34.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:192:0) after 1m0s
[02:01:35.010] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:192:0)
[02:01:35.010] Timer tick, asking Buildbucket for the build status
[02:01:35.264] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:35.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:193:0) after 1m0s
[02:02:35.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:193:0)
[02:02:35.335] Timer tick, asking Buildbucket for the build status
[02:02:35.671] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:35.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:194:0) after 1m0s
[02:03:35.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:194:0)
[02:03:35.700] Timer tick, asking Buildbucket for the build status
[02:03:35.789] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:35.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:195:0) after 1m0s
[02:04:35.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:195:0)
[02:04:35.839] Timer tick, asking Buildbucket for the build status
[02:04:35.940] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:35.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:196:0) after 1m0s
[02:05:36.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:196:0)
[02:05:36.013] Timer tick, asking Buildbucket for the build status
[02:05:36.103] Build 8863162868160879280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:36.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028592930500530192:197:0) after 1m0s
[02:06:16.991] Received PubSub notification, asking Buildbucket for the build status
[02:06:17.064] Build 8863162868160879280: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:06:17.065] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1605837975895721",
    "created_by": "project:infra",
    "created_ts": "1605826232717347",
    "id": "8863162868160879280",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"89.0.4330.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f12448e3-c7fa-4df8-929b-4f96928602cb\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"89.0.4330.2\"}}",
    "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-pz0i\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"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\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1605826240420617",
    "status": "COMPLETED",
    "status_changed_ts": "1605837976245299",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9028592930500530192",
      "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/8863162868160879280/+/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:4ffb8551aa737510",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1605837976258739",
    "url": "https://ci.chromium.org/b/8863162868160879280",
    "utcnow_ts": "1605837977056167"
  }
}
[02:06:17.065] Invocation finished in 3h15m45.962267382s with status SUCCEEDED