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

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

{
  "version": "87.0.4272.2"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[19:54:04.657] New invocation is queued and will start shortly
[19:54:04.657] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[19:54:05.784] Starting the invocation (attempt 1)
[19:54:05.835] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:54:05.835] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:54:05.836] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9033677461330260800",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"87.0.4272.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"3d2d9467-7b90-4055-989b-28978901b02e\",\"title\":\"publish_tarball/0\"}]},\"version\":\"87.0.4272.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:9033677461330260800",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[19:54:06.564] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1600977245989951",
    "id": "8868247399268204416",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4272.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"3d2d9467-7b90-4055-989b-28978901b02e\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4272.2\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1600977246354069",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9033677461330260800",
      "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/8868247399268204416/+/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": "1600977246354200",
    "url": "https://ci.chromium.org/b/8868247399268204416",
    "utcnow_ts": "1600977246551003"
  }
}
[19:54:06.564] Task URL: https://ci.chromium.org/b/8868247399268204416
[19:54:06.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:2:0) after 1m0s
[19:54:11.985] Received PubSub notification, asking Buildbucket for the build status
[19:54:12.306] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:06.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:2:0)
[19:55:06.701] Timer tick, asking Buildbucket for the build status
[19:55:07.097] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:07.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:4:0) after 1m0s
[19:56:07.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:4:0)
[19:56:07.202] Timer tick, asking Buildbucket for the build status
[19:56:07.393] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:07.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:5:0) after 1m0s
[19:57:07.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:5:0)
[19:57:07.570] Timer tick, asking Buildbucket for the build status
[19:57:07.797] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:07.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:6:0) after 1m0s
[19:58:08.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:6:0)
[19:58:08.364] Timer tick, asking Buildbucket for the build status
[19:58:08.544] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:08.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:7:0) after 1m0s
[19:59:09.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:7:0)
[19:59:09.609] Timer tick, asking Buildbucket for the build status
[19:59:10.120] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:10.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:8:0) after 1m0s
[20:00:10.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:8:0)
[20:00:10.391] Timer tick, asking Buildbucket for the build status
[20:00:10.514] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:10.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:9:0) after 1m0s
[20:01:10.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:9:0)
[20:01:10.593] Timer tick, asking Buildbucket for the build status
[20:01:11.327] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:11.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:10:0) after 1m0s
[20:02:11.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:10:0)
[20:02:11.499] Timer tick, asking Buildbucket for the build status
[20:02:11.607] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:11.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:11:0) after 1m0s
[20:03:11.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:11:0)
[20:03:11.678] Timer tick, asking Buildbucket for the build status
[20:03:11.769] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:11.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:12:0) after 1m0s
[20:04:11.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:12:0)
[20:04:11.987] Timer tick, asking Buildbucket for the build status
[20:04:12.179] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:12.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:13:0) after 1m0s
[20:05:12.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:13:0)
[20:05:12.688] Timer tick, asking Buildbucket for the build status
[20:05:12.916] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:12.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:14:0) after 1m0s
[20:06:13.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:14:0)
[20:06:13.086] Timer tick, asking Buildbucket for the build status
[20:06:13.202] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:13.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:15:0) after 1m0s
[20:07:13.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:15:0)
[20:07:13.497] Timer tick, asking Buildbucket for the build status
[20:07:13.588] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:13.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:16:0) after 1m0s
[20:08:13.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:16:0)
[20:08:13.841] Timer tick, asking Buildbucket for the build status
[20:08:13.933] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:13.933] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:17:0) after 1m0s
[20:09:14.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:17:0)
[20:09:14.045] Timer tick, asking Buildbucket for the build status
[20:09:14.227] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:14.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:18:0) after 1m0s
[20:10:14.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:18:0)
[20:10:14.411] Timer tick, asking Buildbucket for the build status
[20:10:14.741] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:14.741] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:19:0) after 1m0s
[20:11:14.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:19:0)
[20:11:14.910] Timer tick, asking Buildbucket for the build status
[20:11:15.028] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:15.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:20:0) after 1m0s
[20:12:15.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:20:0)
[20:12:15.076] Timer tick, asking Buildbucket for the build status
[20:12:15.208] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:15.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:21:0) after 1m0s
[20:13:15.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:21:0)
[20:13:15.319] Timer tick, asking Buildbucket for the build status
[20:13:15.413] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:15.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:22:0) after 1m0s
[20:14:15.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:22:0)
[20:14:15.578] Timer tick, asking Buildbucket for the build status
[20:14:16.231] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:16.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:23:0) after 1m0s
[20:15:16.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:23:0)
[20:15:16.277] Timer tick, asking Buildbucket for the build status
[20:15:16.421] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:16.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:24:0) after 1m0s
[20:16:16.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:24:0)
[20:16:16.454] Timer tick, asking Buildbucket for the build status
[20:16:17.536] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:17.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:25:0) after 1m0s
[20:17:17.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:25:0)
[20:17:17.560] Timer tick, asking Buildbucket for the build status
[20:17:17.705] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:17.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:26:0) after 1m0s
[20:18:17.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:26:0)
[20:18:17.758] Timer tick, asking Buildbucket for the build status
[20:18:17.926] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:17.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:27:0) after 1m0s
[20:19:17.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:27:0)
[20:19:17.948] Timer tick, asking Buildbucket for the build status
[20:19:18.189] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:18.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:28:0) after 1m0s
[20:20:18.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:28:0)
[20:20:18.256] Timer tick, asking Buildbucket for the build status
[20:20:18.374] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:18.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:29:0) after 1m0s
[20:21:18.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:29:0)
[20:21:18.468] Timer tick, asking Buildbucket for the build status
[20:21:20.044] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:20.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:30:0) after 1m0s
[20:22:20.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:30:0)
[20:22:20.087] Timer tick, asking Buildbucket for the build status
[20:22:20.200] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:20.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:31:0) after 1m0s
[20:23:20.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:31:0)
[20:23:20.257] Timer tick, asking Buildbucket for the build status
[20:23:20.378] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:20.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:32:0) after 1m0s
[20:24:20.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:32:0)
[20:24:20.410] Timer tick, asking Buildbucket for the build status
[20:24:20.563] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:20.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:33:0) after 1m0s
[20:25:20.598] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:33:0)
[20:25:20.599] Timer tick, asking Buildbucket for the build status
[20:25:20.996] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:20.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:34:0) after 1m0s
[20:26:21.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:34:0)
[20:26:21.051] Timer tick, asking Buildbucket for the build status
[20:26:21.964] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:21.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:35:0) after 1m0s
[20:27:22.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:35:0)
[20:27:22.028] Timer tick, asking Buildbucket for the build status
[20:27:22.129] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:22.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:36:0) after 1m0s
[20:28:22.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:36:0)
[20:28:22.167] Timer tick, asking Buildbucket for the build status
[20:28:22.245] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:22.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:37:0) after 1m0s
[20:29:22.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:37:0)
[20:29:22.312] Timer tick, asking Buildbucket for the build status
[20:29:22.520] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:22.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:38:0) after 1m0s
[20:30:22.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:38:0)
[20:30:22.559] Timer tick, asking Buildbucket for the build status
[20:30:22.665] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:22.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:39:0) after 1m0s
[20:31:22.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:39:0)
[20:31:22.771] Timer tick, asking Buildbucket for the build status
[20:31:24.909] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:24.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:40:0) after 1m0s
[20:32:24.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:40:0)
[20:32:24.943] Timer tick, asking Buildbucket for the build status
[20:32:25.298] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:25.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:41:0) after 1m0s
[20:33:25.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:41:0)
[20:33:25.380] Timer tick, asking Buildbucket for the build status
[20:33:25.502] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:25.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:42:0) after 1m0s
[20:34:25.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:42:0)
[20:34:25.572] Timer tick, asking Buildbucket for the build status
[20:34:26.182] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:26.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:43:0) after 1m0s
[20:35:26.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:43:0)
[20:35:26.202] Timer tick, asking Buildbucket for the build status
[20:35:26.634] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:26.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:44:0) after 1m0s
[20:36:26.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:44:0)
[20:36:26.667] Timer tick, asking Buildbucket for the build status
[20:36:26.992] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:26.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:45:0) after 1m0s
[20:37:27.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:45:0)
[20:37:27.096] Timer tick, asking Buildbucket for the build status
[20:37:27.756] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:27.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:46:0) after 1m0s
[20:38:27.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:46:0)
[20:38:27.876] Timer tick, asking Buildbucket for the build status
[20:38:27.960] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:27.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:47:0) after 1m0s
[20:39:27.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:47:0)
[20:39:27.982] Timer tick, asking Buildbucket for the build status
[20:39:28.179] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:28.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:48:0) after 1m0s
[20:40:28.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:48:0)
[20:40:28.218] Timer tick, asking Buildbucket for the build status
[20:40:28.358] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:28.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:49:0) after 1m0s
[20:41:28.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:49:0)
[20:41:28.460] Timer tick, asking Buildbucket for the build status
[20:41:28.626] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:28.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:50:0) after 1m0s
[20:42:28.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:50:0)
[20:42:28.639] Timer tick, asking Buildbucket for the build status
[20:42:28.716] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:28.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:51:0) after 1m0s
[20:43:28.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:51:0)
[20:43:28.737] Timer tick, asking Buildbucket for the build status
[20:43:28.972] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:28.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:52:0) after 1m0s
[20:44:29.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:52:0)
[20:44:29.088] Timer tick, asking Buildbucket for the build status
[20:44:29.280] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:29.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:53:0) after 1m0s
[20:45:29.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:53:0)
[20:45:29.259] Timer tick, asking Buildbucket for the build status
[20:45:29.955] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:29.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:54:0) after 1m0s
[20:46:30.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:54:0)
[20:46:30.108] Timer tick, asking Buildbucket for the build status
[20:46:30.334] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:30.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:55:0) after 1m0s
[20:47:30.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:55:0)
[20:47:30.372] Timer tick, asking Buildbucket for the build status
[20:47:30.483] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:30.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:56:0) after 1m0s
[20:48:30.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:56:0)
[20:48:30.667] Timer tick, asking Buildbucket for the build status
[20:48:30.734] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:30.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:57:0) after 1m0s
[20:49:30.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:57:0)
[20:49:30.937] Timer tick, asking Buildbucket for the build status
[20:49:31.072] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:31.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:58:0) after 1m0s
[20:50:32.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:58:0)
[20:50:32.082] Timer tick, asking Buildbucket for the build status
[20:50:32.222] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:32.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:59:0) after 1m0s
[20:51:32.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:59:0)
[20:51:32.284] Timer tick, asking Buildbucket for the build status
[20:51:33.009] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:33.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:60:0) after 1m0s
[20:52:33.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:60:0)
[20:52:33.012] Timer tick, asking Buildbucket for the build status
[20:52:33.310] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:33.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:61:0) after 1m0s
[20:53:33.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:61:0)
[20:53:33.324] Timer tick, asking Buildbucket for the build status
[20:53:33.497] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:33.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:62:0) after 1m0s
[20:54:33.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:62:0)
[20:54:33.596] Timer tick, asking Buildbucket for the build status
[20:54:33.766] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:33.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:63:0) after 1m0s
[20:55:33.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:63:0)
[20:55:33.761] Timer tick, asking Buildbucket for the build status
[20:55:34.301] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:34.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:64:0) after 1m0s
[20:56:34.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:64:0)
[20:56:34.531] Timer tick, asking Buildbucket for the build status
[20:56:34.631] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:34.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:65:0) after 1m0s
[20:57:34.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:65:0)
[20:57:34.975] Timer tick, asking Buildbucket for the build status
[20:57:35.862] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:35.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:66:0) after 1m0s
[20:58:36.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:66:0)
[20:58:36.307] Timer tick, asking Buildbucket for the build status
[20:58:36.413] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:36.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:67:0) after 1m0s
[20:59:36.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:67:0)
[20:59:36.677] Timer tick, asking Buildbucket for the build status
[20:59:36.809] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:36.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:68:0) after 1m0s
[21:00:37.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:68:0)
[21:00:37.298] Timer tick, asking Buildbucket for the build status
[21:00:37.631] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:37.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:69:0) after 1m0s
[21:01:37.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:69:0)
[21:01:37.796] Timer tick, asking Buildbucket for the build status
[21:01:37.856] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:37.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:70:0) after 1m0s
[21:02:38.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:70:0)
[21:02:38.003] Timer tick, asking Buildbucket for the build status
[21:02:38.380] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:38.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:71:0) after 1m0s
[21:03:39.072] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:71:0)
[21:03:39.072] Timer tick, asking Buildbucket for the build status
[21:03:39.345] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:39.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:72:0) after 1m0s
[21:04:40.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:72:0)
[21:04:40.074] Timer tick, asking Buildbucket for the build status
[21:04:40.565] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:40.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:73:0) after 1m0s
[21:05:41.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:73:0)
[21:05:41.073] Timer tick, asking Buildbucket for the build status
[21:05:41.200] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:41.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:74:0) after 1m0s
[21:06:41.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:74:0)
[21:06:41.322] Timer tick, asking Buildbucket for the build status
[21:06:41.446] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:41.446] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:75:0) after 1m0s
[21:07:41.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:75:0)
[21:07:41.544] Timer tick, asking Buildbucket for the build status
[21:07:42.096] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:42.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:76:0) after 1m0s
[21:08:42.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:76:0)
[21:08:42.169] Timer tick, asking Buildbucket for the build status
[21:08:42.646] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:42.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:77:0) after 1m0s
[21:09:42.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:77:0)
[21:09:42.790] Timer tick, asking Buildbucket for the build status
[21:09:44.283] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:44.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:78:0) after 1m0s
[21:10:44.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:78:0)
[21:10:44.401] Timer tick, asking Buildbucket for the build status
[21:10:44.592] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:44.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:79:0) after 1m0s
[21:11:44.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:79:0)
[21:11:44.722] Timer tick, asking Buildbucket for the build status
[21:11:44.800] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:44.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:80:0) after 1m0s
[21:12:44.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:80:0)
[21:12:44.972] Timer tick, asking Buildbucket for the build status
[21:12:45.066] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:45.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:81:0) after 1m0s
[21:13:45.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:81:0)
[21:13:45.089] Timer tick, asking Buildbucket for the build status
[21:13:45.180] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:45.180] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:82:0) after 1m0s
[21:14:45.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:82:0)
[21:14:45.205] Timer tick, asking Buildbucket for the build status
[21:14:45.523] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:45.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:83:0) after 1m0s
[21:15:45.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:83:0)
[21:15:45.546] Timer tick, asking Buildbucket for the build status
[21:15:45.758] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:45.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:84:0) after 1m0s
[21:16:45.772] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:84:0)
[21:16:45.772] Timer tick, asking Buildbucket for the build status
[21:16:45.942] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:45.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:85:0) after 1m0s
[21:17:45.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:85:0)
[21:17:45.997] Timer tick, asking Buildbucket for the build status
[21:17:46.103] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:46.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:86:0) after 1m0s
[21:18:46.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:86:0)
[21:18:46.127] Timer tick, asking Buildbucket for the build status
[21:18:46.329] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:46.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:87:0) after 1m0s
[21:19:46.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:87:0)
[21:19:46.331] Timer tick, asking Buildbucket for the build status
[21:19:46.491] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:46.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:88:0) after 1m0s
[21:20:46.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:88:0)
[21:20:46.584] Timer tick, asking Buildbucket for the build status
[21:20:46.674] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:46.674] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:89:0) after 1m0s
[21:21:46.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:89:0)
[21:21:46.712] Timer tick, asking Buildbucket for the build status
[21:21:46.993] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:46.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:90:0) after 1m0s
[21:22:47.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:90:0)
[21:22:47.027] Timer tick, asking Buildbucket for the build status
[21:22:47.213] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:47.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:91:0) after 1m0s
[21:23:47.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:91:0)
[21:23:47.243] Timer tick, asking Buildbucket for the build status
[21:23:47.336] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:47.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:92:0) after 1m0s
[21:24:47.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:92:0)
[21:24:47.358] Timer tick, asking Buildbucket for the build status
[21:24:47.784] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:47.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:93:0) after 1m0s
[21:25:47.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:93:0)
[21:25:47.817] Timer tick, asking Buildbucket for the build status
[21:25:47.915] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:47.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:94:0) after 1m0s
[21:26:47.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:94:0)
[21:26:47.949] Timer tick, asking Buildbucket for the build status
[21:26:48.016] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:48.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:95:0) after 1m0s
[21:27:48.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:95:0)
[21:27:48.029] Timer tick, asking Buildbucket for the build status
[21:27:53.422] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:53.422] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:96:0) after 1m0s
[21:28:53.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:96:0)
[21:28:53.469] Timer tick, asking Buildbucket for the build status
[21:28:53.640] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:53.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:97:0) after 1m0s
[21:29:53.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:97:0)
[21:29:53.675] Timer tick, asking Buildbucket for the build status
[21:29:53.889] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:53.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:98:0) after 1m0s
[21:30:53.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:98:0)
[21:30:53.965] Timer tick, asking Buildbucket for the build status
[21:30:54.058] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:54.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:99:0) after 1m0s
[21:31:54.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:99:0)
[21:31:54.067] Timer tick, asking Buildbucket for the build status
[21:31:54.155] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:54.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:100:0) after 1m0s
[21:32:54.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:100:0)
[21:32:54.184] Timer tick, asking Buildbucket for the build status
[21:32:54.411] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:54.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:101:0) after 1m0s
[21:33:54.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:101:0)
[21:33:54.445] Timer tick, asking Buildbucket for the build status
[21:33:54.572] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:54.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:102:0) after 1m0s
[21:34:54.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:102:0)
[21:34:54.611] Timer tick, asking Buildbucket for the build status
[21:34:54.721] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:54.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:103:0) after 1m0s
[21:35:54.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:103:0)
[21:35:54.788] Timer tick, asking Buildbucket for the build status
[21:35:54.865] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:54.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:104:0) after 1m0s
[21:36:54.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:104:0)
[21:36:54.884] Timer tick, asking Buildbucket for the build status
[21:36:54.964] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:54.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:105:0) after 1m0s
[21:37:55.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:105:0)
[21:37:55.028] Timer tick, asking Buildbucket for the build status
[21:37:55.149] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:55.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:106:0) after 1m0s
[21:38:56.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:106:0)
[21:38:56.436] Timer tick, asking Buildbucket for the build status
[21:38:56.516] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:56.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:107:0) after 1m0s
[21:39:56.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:107:0)
[21:39:56.559] Timer tick, asking Buildbucket for the build status
[21:39:56.793] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:56.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:108:0) after 1m0s
[21:40:56.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:108:0)
[21:40:56.820] Timer tick, asking Buildbucket for the build status
[21:40:56.881] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:56.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:109:0) after 1m0s
[21:41:57.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:109:0)
[21:41:57.482] Timer tick, asking Buildbucket for the build status
[21:41:57.698] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:57.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:110:0) after 1m0s
[21:42:57.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:110:0)
[21:42:57.971] Timer tick, asking Buildbucket for the build status
[21:42:58.287] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:58.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:111:0) after 1m0s
[21:43:58.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:111:0)
[21:43:58.384] Timer tick, asking Buildbucket for the build status
[21:43:58.765] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:58.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:112:0) after 1m0s
[21:44:59.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:112:0)
[21:44:59.258] Timer tick, asking Buildbucket for the build status
[21:44:59.379] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:59.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:113:0) after 1m0s
[21:46:00.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:113:0)
[21:46:00.133] Timer tick, asking Buildbucket for the build status
[21:46:00.857] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:00.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:114:0) after 1m0s
[21:47:03.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:114:0)
[21:47:03.766] Timer tick, asking Buildbucket for the build status
[21:47:04.047] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:04.047] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:115:0) after 1m0s
[21:48:04.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:115:0)
[21:48:04.371] Timer tick, asking Buildbucket for the build status
[21:48:04.565] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:04.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:116:0) after 1m0s
[21:49:05.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:116:0)
[21:49:05.789] Timer tick, asking Buildbucket for the build status
[21:49:06.137] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:06.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:117:0) after 1m0s
[21:50:07.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:117:0)
[21:50:07.444] Timer tick, asking Buildbucket for the build status
[21:50:08.772] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:08.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:118:0) after 1m0s
[21:51:09.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:118:0)
[21:51:09.545] Timer tick, asking Buildbucket for the build status
[21:51:09.613] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:09.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:119:0) after 1m0s
[21:52:09.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:119:0)
[21:52:09.811] Timer tick, asking Buildbucket for the build status
[21:52:10.034] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:10.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:120:0) after 1m0s
[21:53:10.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:120:0)
[21:53:10.392] Timer tick, asking Buildbucket for the build status
[21:53:10.542] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:10.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:121:0) after 1m0s
[21:54:10.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:121:0)
[21:54:10.674] Timer tick, asking Buildbucket for the build status
[21:54:11.343] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:11.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:122:0) after 1m0s
[21:55:11.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:122:0)
[21:55:11.420] Timer tick, asking Buildbucket for the build status
[21:55:11.588] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:11.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:123:0) after 1m0s
[21:56:11.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:123:0)
[21:56:11.667] Timer tick, asking Buildbucket for the build status
[21:56:15.155] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:15.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:124:0) after 1m0s
[21:57:15.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:124:0)
[21:57:15.276] Timer tick, asking Buildbucket for the build status
[21:57:15.417] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:15.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:125:0) after 1m0s
[21:58:15.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:125:0)
[21:58:15.496] Timer tick, asking Buildbucket for the build status
[21:58:15.591] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:15.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:126:0) after 1m0s
[21:59:15.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:126:0)
[21:59:15.745] Timer tick, asking Buildbucket for the build status
[21:59:16.204] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:16.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:127:0) after 1m0s
[22:00:16.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:127:0)
[22:00:16.249] Timer tick, asking Buildbucket for the build status
[22:00:16.331] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:16.331] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:128:0) after 1m0s
[22:01:16.504] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:128:0)
[22:01:16.504] Timer tick, asking Buildbucket for the build status
[22:01:16.599] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:16.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:129:0) after 1m0s
[22:02:17.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:129:0)
[22:02:17.037] Timer tick, asking Buildbucket for the build status
[22:02:17.172] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:17.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:130:0) after 1m0s
[22:03:17.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:130:0)
[22:03:17.356] Timer tick, asking Buildbucket for the build status
[22:03:17.453] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:17.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:131:0) after 1m0s
[22:04:17.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:131:0)
[22:04:17.686] Timer tick, asking Buildbucket for the build status
[22:04:18.434] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:18.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:132:0) after 1m0s
[22:05:18.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:132:0)
[22:05:18.450] Timer tick, asking Buildbucket for the build status
[22:05:18.902] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:18.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:133:0) after 1m0s
[22:06:18.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:133:0)
[22:06:18.911] Timer tick, asking Buildbucket for the build status
[22:06:19.375] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:19.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:134:0) after 1m0s
[22:07:19.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:134:0)
[22:07:19.450] Timer tick, asking Buildbucket for the build status
[22:07:19.535] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:19.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:135:0) after 1m0s
[22:08:19.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:135:0)
[22:08:19.564] Timer tick, asking Buildbucket for the build status
[22:08:19.663] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:19.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:136:0) after 1m0s
[22:09:19.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:136:0)
[22:09:19.698] Timer tick, asking Buildbucket for the build status
[22:09:20.447] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:20.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:137:0) after 1m0s
[22:10:20.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:137:0)
[22:10:20.549] Timer tick, asking Buildbucket for the build status
[22:10:20.622] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:20.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:138:0) after 1m0s
[22:11:20.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:138:0)
[22:11:20.652] Timer tick, asking Buildbucket for the build status
[22:11:20.715] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:20.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:139:0) after 1m0s
[22:12:20.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:139:0)
[22:12:20.759] Timer tick, asking Buildbucket for the build status
[22:12:20.830] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:20.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:140:0) after 1m0s
[22:13:20.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:140:0)
[22:13:20.903] Timer tick, asking Buildbucket for the build status
[22:13:22.247] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:22.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:141:0) after 1m0s
[22:14:22.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:141:0)
[22:14:22.353] Timer tick, asking Buildbucket for the build status
[22:14:22.884] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:22.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:142:0) after 1m0s
[22:15:23.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:142:0)
[22:15:23.116] Timer tick, asking Buildbucket for the build status
[22:15:23.212] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:23.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:143:0) after 1m0s
[22:16:23.280] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:143:0)
[22:16:23.280] Timer tick, asking Buildbucket for the build status
[22:16:23.352] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:23.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:144:0) after 1m0s
[22:17:23.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:144:0)
[22:17:23.366] Timer tick, asking Buildbucket for the build status
[22:17:24.273] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:24.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:145:0) after 1m0s
[22:18:25.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:145:0)
[22:18:25.166] Timer tick, asking Buildbucket for the build status
[22:18:25.481] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:25.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:146:0) after 1m0s
[22:19:26.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:146:0)
[22:19:26.432] Timer tick, asking Buildbucket for the build status
[22:19:26.857] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:26.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:147:0) after 1m0s
[22:20:27.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:147:0)
[22:20:27.092] Timer tick, asking Buildbucket for the build status
[22:20:27.689] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:27.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:148:0) after 1m0s
[22:21:27.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:148:0)
[22:21:27.810] Timer tick, asking Buildbucket for the build status
[22:21:28.102] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:28.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:149:0) after 1m0s
[22:22:28.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:149:0)
[22:22:28.228] Timer tick, asking Buildbucket for the build status
[22:22:28.567] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:28.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:150:0) after 1m0s
[22:23:28.643] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:150:0)
[22:23:28.643] Timer tick, asking Buildbucket for the build status
[22:23:28.750] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:28.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:151:0) after 1m0s
[22:24:28.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:151:0)
[22:24:28.817] Timer tick, asking Buildbucket for the build status
[22:24:28.979] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:28.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:152:0) after 1m0s
[22:25:29.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:152:0)
[22:25:29.084] Timer tick, asking Buildbucket for the build status
[22:25:29.182] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:29.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:153:0) after 1m0s
[22:26:29.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:153:0)
[22:26:29.291] Timer tick, asking Buildbucket for the build status
[22:26:29.442] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:29.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:154:0) after 1m0s
[22:27:29.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:154:0)
[22:27:29.728] Timer tick, asking Buildbucket for the build status
[22:27:29.939] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:29.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:155:0) after 1m0s
[22:28:30.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:155:0)
[22:28:30.118] Timer tick, asking Buildbucket for the build status
[22:28:30.267] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:30.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:156:0) after 1m0s
[22:29:30.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:156:0)
[22:29:30.398] Timer tick, asking Buildbucket for the build status
[22:29:30.593] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:30.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:157:0) after 1m0s
[22:30:30.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:157:0)
[22:30:30.783] Timer tick, asking Buildbucket for the build status
[22:30:30.874] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:30.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:158:0) after 1m0s
[22:31:30.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:158:0)
[22:31:30.989] Timer tick, asking Buildbucket for the build status
[22:31:31.182] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:31.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:159:0) after 1m0s
[22:32:31.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:159:0)
[22:32:31.298] Timer tick, asking Buildbucket for the build status
[22:32:31.923] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:31.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:160:0) after 1m0s
[22:33:31.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:160:0)
[22:33:31.981] Timer tick, asking Buildbucket for the build status
[22:33:32.124] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:32.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:161:0) after 1m0s
[22:34:33.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:161:0)
[22:34:33.022] Timer tick, asking Buildbucket for the build status
[22:34:33.447] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:33.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:162:0) after 1m0s
[22:35:33.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:162:0)
[22:35:33.925] Timer tick, asking Buildbucket for the build status
[22:35:33.988] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:33.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:163:0) after 1m0s
[22:36:34.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:163:0)
[22:36:34.178] Timer tick, asking Buildbucket for the build status
[22:36:34.263] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:34.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:164:0) after 1m0s
[22:37:34.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:164:0)
[22:37:34.535] Timer tick, asking Buildbucket for the build status
[22:37:34.643] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:34.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:165:0) after 1m0s
[22:38:34.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:165:0)
[22:38:34.878] Timer tick, asking Buildbucket for the build status
[22:38:35.192] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:35.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:166:0) after 1m0s
[22:39:35.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:166:0)
[22:39:35.248] Timer tick, asking Buildbucket for the build status
[22:39:35.412] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:35.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:167:0) after 1m0s
[22:40:35.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:167:0)
[22:40:35.496] Timer tick, asking Buildbucket for the build status
[22:40:35.762] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:35.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:168:0) after 1m0s
[22:41:35.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:168:0)
[22:41:35.789] Timer tick, asking Buildbucket for the build status
[22:41:35.904] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:35.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:169:0) after 1m0s
[22:42:35.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:169:0)
[22:42:35.976] Timer tick, asking Buildbucket for the build status
[22:42:36.762] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:36.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:170:0) after 1m0s
[22:43:37.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:170:0)
[22:43:37.804] Timer tick, asking Buildbucket for the build status
[22:43:38.145] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:38.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:171:0) after 1m0s
[22:44:38.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:171:0)
[22:44:38.156] Timer tick, asking Buildbucket for the build status
[22:44:38.374] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:38.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:172:0) after 1m0s
[22:45:38.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:172:0)
[22:45:38.394] Timer tick, asking Buildbucket for the build status
[22:45:38.595] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:38.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:173:0) after 1m0s
[22:46:38.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:173:0)
[22:46:38.641] Timer tick, asking Buildbucket for the build status
[22:46:38.705] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:38.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:174:0) after 1m0s
[22:47:39.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:174:0)
[22:47:39.095] Timer tick, asking Buildbucket for the build status
[22:47:39.304] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:39.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:175:0) after 1m0s
[22:48:39.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:175:0)
[22:48:39.406] Timer tick, asking Buildbucket for the build status
[22:48:39.496] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:39.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:176:0) after 1m0s
[22:49:39.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:176:0)
[22:49:39.601] Timer tick, asking Buildbucket for the build status
[22:49:39.790] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:39.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:177:0) after 1m0s
[22:50:39.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:177:0)
[22:50:39.937] Timer tick, asking Buildbucket for the build status
[22:50:40.035] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:40.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:178:0) after 1m0s
[22:51:40.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:178:0)
[22:51:40.055] Timer tick, asking Buildbucket for the build status
[22:51:40.168] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:40.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:179:0) after 1m0s
[22:52:40.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:179:0)
[22:52:40.257] Timer tick, asking Buildbucket for the build status
[22:52:40.334] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:40.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:180:0) after 1m0s
[22:53:40.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:180:0)
[22:53:40.455] Timer tick, asking Buildbucket for the build status
[22:53:40.670] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:40.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:181:0) after 1m0s
[22:54:40.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:181:0)
[22:54:40.719] Timer tick, asking Buildbucket for the build status
[22:54:40.857] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:40.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:182:0) after 1m0s
[22:55:40.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:182:0)
[22:55:40.887] Timer tick, asking Buildbucket for the build status
[22:55:40.962] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:40.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:183:0) after 1m0s
[22:56:41.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:183:0)
[22:56:41.033] Timer tick, asking Buildbucket for the build status
[22:56:41.104] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:41.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:184:0) after 1m0s
[22:57:41.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:184:0)
[22:57:41.134] Timer tick, asking Buildbucket for the build status
[22:57:41.198] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:41.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:185:0) after 1m0s
[22:58:41.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:185:0)
[22:58:41.314] Timer tick, asking Buildbucket for the build status
[22:58:41.382] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:41.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:186:0) after 1m0s
[22:59:41.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:186:0)
[22:59:41.430] Timer tick, asking Buildbucket for the build status
[22:59:41.542] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:41.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:187:0) after 1m0s
[23:00:41.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:187:0)
[23:00:41.600] Timer tick, asking Buildbucket for the build status
[23:00:41.696] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:41.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:188:0) after 1m0s
[23:01:41.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:188:0)
[23:01:41.886] Timer tick, asking Buildbucket for the build status
[23:01:42.054] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:42.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:189:0) after 1m0s
[23:02:42.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:189:0)
[23:02:42.144] Timer tick, asking Buildbucket for the build status
[23:02:42.242] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:42.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:190:0) after 1m0s
[23:03:42.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:190:0)
[23:03:42.353] Timer tick, asking Buildbucket for the build status
[23:03:42.494] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:42.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:191:0) after 1m0s
[23:04:42.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:191:0)
[23:04:42.577] Timer tick, asking Buildbucket for the build status
[23:04:42.904] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:42.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:192:0) after 1m0s
[23:05:42.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:192:0)
[23:05:42.954] Timer tick, asking Buildbucket for the build status
[23:05:43.101] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:43.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:193:0) after 1m0s
[23:06:43.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:193:0)
[23:06:43.391] Timer tick, asking Buildbucket for the build status
[23:06:43.458] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:43.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:194:0) after 1m0s
[23:07:43.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:194:0)
[23:07:43.574] Timer tick, asking Buildbucket for the build status
[23:07:43.691] Build 8868247399268204416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:43.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9033677461330260800:195:0) after 1m0s
[23:08:18.144] Received PubSub notification, asking Buildbucket for the build status
[23:08:18.246] Build 8868247399268204416: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:08:18.246] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1600988897197152",
    "created_by": "project:infra",
    "created_ts": "1600977245989951",
    "id": "8868247399268204416",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4272.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"3d2d9467-7b90-4055-989b-28978901b02e\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4272.2\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4d1db109d30b9f0068cf0464722c703e05f788cd82e2d29876a9483818e7c333_v2\", \"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-00mt\"], \"image\": [\"chrome-xenial-20091600-9ddf7e422ac\"], \"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\": [\"5531-8ab19d9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1600977249491069",
    "status": "COMPLETED",
    "status_changed_ts": "1600988897775686",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9033677461330260800",
      "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/8868247399268204416/+/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:4eda7fa240e88c10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1600988897796600",
    "url": "https://ci.chromium.org/b/8868247399268204416",
    "utcnow_ts": "1600988898234297"
  }
}
[23:08:18.246] Invocation finished in 3h14m13.607003849s with status SUCCEEDED