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

• parent_buildername:publish_tarball
• user_agent:recipe

[20:00:31.114] New invocation is queued and will start shortly
[20:00:31.114] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[20:00:39.063] Starting the invocation (attempt 1)
[20:00:39.137] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:00:39.138] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:00:39.138] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9038841083188146976",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4183.49\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"cbdc3930-9583-48ed-8fef-8ca92abe7f07\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4183.49\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9038841083188146976",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[20:00:41.602] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1596052839511232",
    "id": "8873411013715614912",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4183.49\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"cbdc3930-9583-48ed-8fef-8ca92abe7f07\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4183.49\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1596052840970557",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038841083188146976",
      "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/8873411013715614912/+/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": "1596052840970788",
    "url": "https://ci.chromium.org/b/8873411013715614912",
    "utcnow_ts": "1596052841580941"
  }
}
[20:00:41.602] Task URL: https://ci.chromium.org/b/8873411013715614912
[20:00:41.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:2:0) after 1m0s
[20:01:41.781] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:2:0)
[20:01:41.781] Timer tick, asking Buildbucket for the build status
[20:01:42.396] Build 8873411013715614912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:42.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:3:0) after 1m0s
[20:01:45.174] Received PubSub notification, asking Buildbucket for the build status
[20:01:45.291] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:42.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:3:0)
[20:02:42.482] Timer tick, asking Buildbucket for the build status
[20:02:42.629] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:42.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:5:0) after 1m0s
[20:03:42.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:5:0)
[20:03:42.802] Timer tick, asking Buildbucket for the build status
[20:03:42.967] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:42.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:6:0) after 1m0s
[20:04:43.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:6:0)
[20:04:43.119] Timer tick, asking Buildbucket for the build status
[20:04:43.414] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:43.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:7:0) after 1m0s
[20:05:43.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:7:0)
[20:05:43.613] Timer tick, asking Buildbucket for the build status
[20:05:44.992] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:44.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:8:0) after 1m0s
[20:06:45.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:8:0)
[20:06:45.085] Timer tick, asking Buildbucket for the build status
[20:06:45.188] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:45.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:9:0) after 1m0s
[20:07:45.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:9:0)
[20:07:45.226] Timer tick, asking Buildbucket for the build status
[20:07:45.320] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:45.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:10:0) after 1m0s
[20:08:45.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:10:0)
[20:08:45.350] Timer tick, asking Buildbucket for the build status
[20:08:45.452] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:45.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:11:0) after 1m0s
[20:09:45.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:11:0)
[20:09:45.495] Timer tick, asking Buildbucket for the build status
[20:09:45.695] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:45.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:12:0) after 1m0s
[20:10:45.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:12:0)
[20:10:45.737] Timer tick, asking Buildbucket for the build status
[20:10:46.459] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:46.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:13:0) after 1m0s
[20:11:46.643] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:13:0)
[20:11:46.643] Timer tick, asking Buildbucket for the build status
[20:11:46.849] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:46.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:14:0) after 1m0s
[20:12:46.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:14:0)
[20:12:46.992] Timer tick, asking Buildbucket for the build status
[20:12:47.458] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:47.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:15:0) after 1m0s
[20:13:47.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:15:0)
[20:13:47.492] Timer tick, asking Buildbucket for the build status
[20:13:47.623] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:47.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:16:0) after 1m0s
[20:14:48.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:16:0)
[20:14:48.319] Timer tick, asking Buildbucket for the build status
[20:14:48.507] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:48.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:17:0) after 1m0s
[20:15:50.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:17:0)
[20:15:50.515] Timer tick, asking Buildbucket for the build status
[20:15:51.037] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:51.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:18:0) after 1m0s
[20:16:51.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:18:0)
[20:16:51.194] Timer tick, asking Buildbucket for the build status
[20:16:51.542] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:51.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:19:0) after 1m0s
[20:17:51.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:19:0)
[20:17:51.820] Timer tick, asking Buildbucket for the build status
[20:17:52.050] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:52.050] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:20:0) after 1m0s
[20:18:52.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:20:0)
[20:18:52.112] Timer tick, asking Buildbucket for the build status
[20:18:52.435] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:52.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:21:0) after 1m0s
[20:19:52.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:21:0)
[20:19:52.490] Timer tick, asking Buildbucket for the build status
[20:19:52.773] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:52.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:22:0) after 1m0s
[20:20:52.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:22:0)
[20:20:52.794] Timer tick, asking Buildbucket for the build status
[20:20:53.449] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:53.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:23:0) after 1m0s
[20:21:53.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:23:0)
[20:21:53.454] Timer tick, asking Buildbucket for the build status
[20:21:53.663] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:53.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:24:0) after 1m0s
[20:22:53.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:24:0)
[20:22:53.687] Timer tick, asking Buildbucket for the build status
[20:22:53.851] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:53.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:25:0) after 1m0s
[20:23:53.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:25:0)
[20:23:53.869] Timer tick, asking Buildbucket for the build status
[20:23:55.429] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:55.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:26:0) after 1m0s
[20:24:55.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:26:0)
[20:24:55.411] Timer tick, asking Buildbucket for the build status
[20:24:55.590] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:55.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:27:0) after 1m0s
[20:25:55.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:27:0)
[20:25:55.621] Timer tick, asking Buildbucket for the build status
[20:25:56.625] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:56.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:28:0) after 1m0s
[20:26:56.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:28:0)
[20:26:56.654] Timer tick, asking Buildbucket for the build status
[20:26:56.791] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:56.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:29:0) after 1m0s
[20:27:56.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:29:0)
[20:27:56.911] Timer tick, asking Buildbucket for the build status
[20:27:57.066] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:57.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:30:0) after 1m0s
[20:28:57.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:30:0)
[20:28:57.160] Timer tick, asking Buildbucket for the build status
[20:28:58.123] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:58.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:31:0) after 1m0s
[20:29:58.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:31:0)
[20:29:58.195] Timer tick, asking Buildbucket for the build status
[20:29:58.261] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:58.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:32:0) after 1m0s
[20:30:58.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:32:0)
[20:30:58.258] Timer tick, asking Buildbucket for the build status
[20:30:58.548] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:58.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:33:0) after 1m0s
[20:31:58.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:33:0)
[20:31:58.602] Timer tick, asking Buildbucket for the build status
[20:31:58.706] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:58.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:34:0) after 1m0s
[20:32:58.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:34:0)
[20:32:58.717] Timer tick, asking Buildbucket for the build status
[20:32:58.847] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:58.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:35:0) after 1m0s
[20:33:58.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:35:0)
[20:33:58.917] Timer tick, asking Buildbucket for the build status
[20:33:59.000] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:59.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:36:0) after 1m0s
[20:34:59.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:36:0)
[20:34:59.033] Timer tick, asking Buildbucket for the build status
[20:35:00.393] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:00.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:37:0) after 1m0s
[20:36:00.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:37:0)
[20:36:00.439] Timer tick, asking Buildbucket for the build status
[20:36:00.603] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:00.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:38:0) after 1m0s
[20:37:01.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:38:0)
[20:37:01.114] Timer tick, asking Buildbucket for the build status
[20:37:01.204] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:01.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:39:0) after 1m0s
[20:38:01.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:39:0)
[20:38:01.641] Timer tick, asking Buildbucket for the build status
[20:38:01.728] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:01.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:40:0) after 1m0s
[20:39:02.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:40:0)
[20:39:02.877] Timer tick, asking Buildbucket for the build status
[20:39:03.028] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:03.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:41:0) after 1m0s
[20:40:03.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:41:0)
[20:40:03.135] Timer tick, asking Buildbucket for the build status
[20:40:03.416] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:03.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:42:0) after 1m0s
[20:41:03.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:42:0)
[20:41:03.422] Timer tick, asking Buildbucket for the build status
[20:41:04.695] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:04.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:43:0) after 1m0s
[20:42:04.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:43:0)
[20:42:04.831] Timer tick, asking Buildbucket for the build status
[20:42:05.084] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:05.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:44:0) after 1m0s
[20:43:05.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:44:0)
[20:43:05.131] Timer tick, asking Buildbucket for the build status
[20:43:05.239] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:05.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:45:0) after 1m0s
[20:44:05.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:45:0)
[20:44:05.357] Timer tick, asking Buildbucket for the build status
[20:44:05.488] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:05.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:46:0) after 1m0s
[20:45:05.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:46:0)
[20:45:05.588] Timer tick, asking Buildbucket for the build status
[20:45:05.769] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:05.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:47:0) after 1m0s
[20:46:05.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:47:0)
[20:46:05.921] Timer tick, asking Buildbucket for the build status
[20:46:06.399] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:06.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:48:0) after 1m0s
[20:47:06.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:48:0)
[20:47:06.450] Timer tick, asking Buildbucket for the build status
[20:47:07.962] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:07.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:49:0) after 1m0s
[20:48:08.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:49:0)
[20:48:08.000] Timer tick, asking Buildbucket for the build status
[20:48:08.683] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:08.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:50:0) after 1m0s
[20:49:08.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:50:0)
[20:49:08.720] Timer tick, asking Buildbucket for the build status
[20:49:08.825] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:08.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:51:0) after 1m0s
[20:50:08.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:51:0)
[20:50:08.919] Timer tick, asking Buildbucket for the build status
[20:50:08.987] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:08.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:52:0) after 1m0s
[20:51:09.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:52:0)
[20:51:09.064] Timer tick, asking Buildbucket for the build status
[20:51:09.245] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:09.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:53:0) after 1m0s
[20:52:09.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:53:0)
[20:52:09.438] Timer tick, asking Buildbucket for the build status
[20:52:09.599] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:09.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:54:0) after 1m0s
[20:53:09.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:54:0)
[20:53:09.759] Timer tick, asking Buildbucket for the build status
[20:53:09.964] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:09.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:55:0) after 1m0s
[20:54:10.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:55:0)
[20:54:10.097] Timer tick, asking Buildbucket for the build status
[20:54:10.207] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:10.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:56:0) after 1m0s
[20:55:10.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:56:0)
[20:55:10.527] Timer tick, asking Buildbucket for the build status
[20:55:10.694] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:10.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:57:0) after 1m0s
[20:56:10.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:57:0)
[20:56:10.727] Timer tick, asking Buildbucket for the build status
[20:56:10.987] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:10.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:58:0) after 1m0s
[20:57:11.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:58:0)
[20:57:11.031] Timer tick, asking Buildbucket for the build status
[20:57:11.442] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:11.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:59:0) after 1m0s
[20:58:11.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:59:0)
[20:58:11.543] Timer tick, asking Buildbucket for the build status
[20:58:11.682] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:11.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:60:0) after 1m0s
[20:59:11.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:60:0)
[20:59:11.705] Timer tick, asking Buildbucket for the build status
[20:59:11.861] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:11.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:61:0) after 1m0s
[21:00:11.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:61:0)
[21:00:11.911] Timer tick, asking Buildbucket for the build status
[21:00:12.237] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:12.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:62:0) after 1m0s
[21:01:12.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:62:0)
[21:01:12.692] Timer tick, asking Buildbucket for the build status
[21:01:12.911] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:12.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:63:0) after 1m0s
[21:02:13.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:63:0)
[21:02:13.079] Timer tick, asking Buildbucket for the build status
[21:02:13.167] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:13.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:64:0) after 1m0s
[21:03:13.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:64:0)
[21:03:13.293] Timer tick, asking Buildbucket for the build status
[21:03:13.374] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:13.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:65:0) after 1m0s
[21:04:13.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:65:0)
[21:04:13.500] Timer tick, asking Buildbucket for the build status
[21:04:13.739] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:13.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:66:0) after 1m0s
[21:05:13.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:66:0)
[21:05:13.871] Timer tick, asking Buildbucket for the build status
[21:05:14.337] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:14.337] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:67:0) after 1m0s
[21:06:14.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:67:0)
[21:06:14.345] Timer tick, asking Buildbucket for the build status
[21:06:14.846] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:14.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:68:0) after 1m0s
[21:07:15.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:68:0)
[21:07:15.410] Timer tick, asking Buildbucket for the build status
[21:07:15.870] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:15.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:69:0) after 1m0s
[21:08:15.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:69:0)
[21:08:15.991] Timer tick, asking Buildbucket for the build status
[21:08:16.110] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:16.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:70:0) after 1m0s
[21:09:16.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:70:0)
[21:09:16.145] Timer tick, asking Buildbucket for the build status
[21:09:16.213] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:16.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:71:0) after 1m0s
[21:10:16.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:71:0)
[21:10:16.329] Timer tick, asking Buildbucket for the build status
[21:10:16.542] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:16.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:72:0) after 1m0s
[21:11:16.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:72:0)
[21:11:16.566] Timer tick, asking Buildbucket for the build status
[21:11:16.751] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:16.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:73:0) after 1m0s
[21:12:16.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:73:0)
[21:12:16.793] Timer tick, asking Buildbucket for the build status
[21:12:17.026] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:17.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:74:0) after 1m0s
[21:13:17.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:74:0)
[21:13:17.008] Timer tick, asking Buildbucket for the build status
[21:13:17.120] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:17.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:75:0) after 1m0s
[21:14:17.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:75:0)
[21:14:17.309] Timer tick, asking Buildbucket for the build status
[21:14:17.388] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:17.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:76:0) after 1m0s
[21:15:17.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:76:0)
[21:15:17.830] Timer tick, asking Buildbucket for the build status
[21:15:18.041] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:18.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:77:0) after 1m0s
[21:16:18.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:77:0)
[21:16:18.537] Timer tick, asking Buildbucket for the build status
[21:16:18.960] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:18.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:78:0) after 1m0s
[21:17:19.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:78:0)
[21:17:19.191] Timer tick, asking Buildbucket for the build status
[21:17:19.293] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:19.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:79:0) after 1m0s
[21:18:19.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:79:0)
[21:18:19.457] Timer tick, asking Buildbucket for the build status
[21:18:19.566] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:19.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:80:0) after 1m0s
[21:19:19.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:80:0)
[21:19:19.694] Timer tick, asking Buildbucket for the build status
[21:19:19.782] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:19.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:81:0) after 1m0s
[21:20:20.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:81:0)
[21:20:20.190] Timer tick, asking Buildbucket for the build status
[21:20:20.263] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:20.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:82:0) after 1m0s
[21:21:20.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:82:0)
[21:21:20.370] Timer tick, asking Buildbucket for the build status
[21:21:20.849] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:20.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:83:0) after 1m0s
[21:22:21.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:83:0)
[21:22:21.032] Timer tick, asking Buildbucket for the build status
[21:22:21.142] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:21.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:84:0) after 1m0s
[21:23:21.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:84:0)
[21:23:21.402] Timer tick, asking Buildbucket for the build status
[21:23:21.468] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:21.468] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:85:0) after 1m0s
[21:24:21.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:85:0)
[21:24:21.538] Timer tick, asking Buildbucket for the build status
[21:24:21.730] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:21.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:86:0) after 1m0s
[21:25:21.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:86:0)
[21:25:21.737] Timer tick, asking Buildbucket for the build status
[21:25:21.844] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:21.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:87:0) after 1m0s
[21:26:21.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:87:0)
[21:26:21.972] Timer tick, asking Buildbucket for the build status
[21:26:22.428] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:22.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:88:0) after 1m0s
[21:27:22.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:88:0)
[21:27:22.507] Timer tick, asking Buildbucket for the build status
[21:27:22.654] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:22.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:89:0) after 1m0s
[21:28:22.706] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:89:0)
[21:28:22.706] Timer tick, asking Buildbucket for the build status
[21:28:24.034] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:24.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:90:0) after 1m0s
[21:29:24.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:90:0)
[21:29:24.085] Timer tick, asking Buildbucket for the build status
[21:29:24.462] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:24.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:91:0) after 1m0s
[21:30:24.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:91:0)
[21:30:24.495] Timer tick, asking Buildbucket for the build status
[21:30:24.576] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:24.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:92:0) after 1m0s
[21:31:24.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:92:0)
[21:31:24.615] Timer tick, asking Buildbucket for the build status
[21:31:24.869] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:24.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:93:0) after 1m0s
[21:32:24.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:93:0)
[21:32:24.925] Timer tick, asking Buildbucket for the build status
[21:32:25.053] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:25.053] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:94:0) after 1m0s
[21:33:25.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:94:0)
[21:33:25.103] Timer tick, asking Buildbucket for the build status
[21:33:25.312] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:25.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:95:0) after 1m0s
[21:34:25.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:95:0)
[21:34:25.335] Timer tick, asking Buildbucket for the build status
[21:34:25.473] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:25.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:96:0) after 1m0s
[21:35:25.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:96:0)
[21:35:25.513] Timer tick, asking Buildbucket for the build status
[21:35:25.654] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:25.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:97:0) after 1m0s
[21:36:25.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:97:0)
[21:36:25.668] Timer tick, asking Buildbucket for the build status
[21:36:25.810] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:25.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:98:0) after 1m0s
[21:37:25.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:98:0)
[21:37:25.878] Timer tick, asking Buildbucket for the build status
[21:37:26.392] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:26.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:99:0) after 1m0s
[21:38:26.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:99:0)
[21:38:26.446] Timer tick, asking Buildbucket for the build status
[21:38:26.712] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:26.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:100:0) after 1m0s
[21:39:26.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:100:0)
[21:39:26.734] Timer tick, asking Buildbucket for the build status
[21:39:29.176] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:29.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:101:0) after 1m0s
[21:40:29.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:101:0)
[21:40:29.206] Timer tick, asking Buildbucket for the build status
[21:40:30.253] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:30.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:102:0) after 1m0s
[21:41:30.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:102:0)
[21:41:30.355] Timer tick, asking Buildbucket for the build status
[21:41:30.656] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:30.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:103:0) after 1m0s
[21:42:30.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:103:0)
[21:42:30.693] Timer tick, asking Buildbucket for the build status
[21:42:30.785] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:30.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:104:0) after 1m0s
[21:43:30.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:104:0)
[21:43:30.851] Timer tick, asking Buildbucket for the build status
[21:43:31.055] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:31.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:105:0) after 1m0s
[21:44:31.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:105:0)
[21:44:31.134] Timer tick, asking Buildbucket for the build status
[21:44:31.253] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:31.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:106:0) after 1m0s
[21:45:31.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:106:0)
[21:45:31.344] Timer tick, asking Buildbucket for the build status
[21:45:31.638] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:31.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:107:0) after 1m0s
[21:46:31.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:107:0)
[21:46:31.713] Timer tick, asking Buildbucket for the build status
[21:46:32.481] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:32.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:108:0) after 1m0s
[21:47:32.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:108:0)
[21:47:32.513] Timer tick, asking Buildbucket for the build status
[21:47:32.708] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:32.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:109:0) after 1m0s
[21:48:32.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:109:0)
[21:48:32.736] Timer tick, asking Buildbucket for the build status
[21:48:32.934] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:32.934] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:110:0) after 1m0s
[21:49:32.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:110:0)
[21:49:32.996] Timer tick, asking Buildbucket for the build status
[21:49:33.241] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:33.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:111:0) after 1m0s
[21:50:33.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:111:0)
[21:50:33.349] Timer tick, asking Buildbucket for the build status
[21:50:33.605] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:33.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:112:0) after 1m0s
[21:51:33.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:112:0)
[21:51:33.734] Timer tick, asking Buildbucket for the build status
[21:51:34.013] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:34.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:113:0) after 1m0s
[21:52:34.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:113:0)
[21:52:34.127] Timer tick, asking Buildbucket for the build status
[21:52:34.440] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:34.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:114:0) after 1m0s
[21:53:34.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:114:0)
[21:53:34.492] Timer tick, asking Buildbucket for the build status
[21:53:34.581] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:34.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:115:0) after 1m0s
[21:54:34.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:115:0)
[21:54:34.603] Timer tick, asking Buildbucket for the build status
[21:54:34.708] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:34.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:116:0) after 1m0s
[21:55:34.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:116:0)
[21:55:34.759] Timer tick, asking Buildbucket for the build status
[21:55:34.873] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:34.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:117:0) after 1m0s
[21:56:34.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:117:0)
[21:56:34.940] Timer tick, asking Buildbucket for the build status
[21:56:35.288] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:35.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:118:0) after 1m0s
[21:57:35.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:118:0)
[21:57:35.307] Timer tick, asking Buildbucket for the build status
[21:57:35.460] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:35.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:119:0) after 1m0s
[21:58:35.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:119:0)
[21:58:35.461] Timer tick, asking Buildbucket for the build status
[21:58:35.688] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:35.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:120:0) after 1m0s
[21:59:35.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:120:0)
[21:59:35.783] Timer tick, asking Buildbucket for the build status
[21:59:35.890] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:35.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:121:0) after 1m0s
[22:00:35.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:121:0)
[22:00:35.955] Timer tick, asking Buildbucket for the build status
[22:00:36.047] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:36.047] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:122:0) after 1m0s
[22:01:36.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:122:0)
[22:01:36.137] Timer tick, asking Buildbucket for the build status
[22:01:36.832] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:36.832] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:123:0) after 1m0s
[22:02:36.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:123:0)
[22:02:36.858] Timer tick, asking Buildbucket for the build status
[22:02:37.129] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:37.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:124:0) after 1m0s
[22:03:37.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:124:0)
[22:03:37.195] Timer tick, asking Buildbucket for the build status
[22:03:37.597] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:37.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:125:0) after 1m0s
[22:04:37.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:125:0)
[22:04:37.624] Timer tick, asking Buildbucket for the build status
[22:04:37.838] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:37.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:126:0) after 1m0s
[22:05:37.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:126:0)
[22:05:37.967] Timer tick, asking Buildbucket for the build status
[22:05:38.288] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:38.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:127:0) after 1m0s
[22:06:38.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:127:0)
[22:06:38.331] Timer tick, asking Buildbucket for the build status
[22:06:38.725] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:38.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:128:0) after 1m0s
[22:07:38.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:128:0)
[22:07:38.842] Timer tick, asking Buildbucket for the build status
[22:07:39.001] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:39.001] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:129:0) after 1m0s
[22:08:39.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:129:0)
[22:08:39.049] Timer tick, asking Buildbucket for the build status
[22:08:39.512] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:39.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:130:0) after 1m0s
[22:09:39.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:130:0)
[22:09:39.538] Timer tick, asking Buildbucket for the build status
[22:09:39.845] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:39.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:131:0) after 1m0s
[22:10:39.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:131:0)
[22:10:39.867] Timer tick, asking Buildbucket for the build status
[22:10:40.141] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:40.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:132:0) after 1m0s
[22:11:40.207] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:132:0)
[22:11:40.207] Timer tick, asking Buildbucket for the build status
[22:11:40.654] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:40.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:133:0) after 1m0s
[22:12:40.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:133:0)
[22:12:40.869] Timer tick, asking Buildbucket for the build status
[22:12:40.966] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:40.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:134:0) after 1m0s
[22:13:41.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:134:0)
[22:13:41.039] Timer tick, asking Buildbucket for the build status
[22:13:41.152] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:41.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:135:0) after 1m0s
[22:14:41.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:135:0)
[22:14:41.218] Timer tick, asking Buildbucket for the build status
[22:14:41.348] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:41.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:136:0) after 1m0s
[22:15:41.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:136:0)
[22:15:41.366] Timer tick, asking Buildbucket for the build status
[22:15:41.462] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:41.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:137:0) after 1m0s
[22:16:41.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:137:0)
[22:16:41.530] Timer tick, asking Buildbucket for the build status
[22:16:42.042] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:42.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:138:0) after 1m0s
[22:17:42.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:138:0)
[22:17:42.217] Timer tick, asking Buildbucket for the build status
[22:17:42.342] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:42.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:139:0) after 1m0s
[22:18:42.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:139:0)
[22:18:42.514] Timer tick, asking Buildbucket for the build status
[22:18:42.671] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:42.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:140:0) after 1m0s
[22:19:42.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:140:0)
[22:19:42.702] Timer tick, asking Buildbucket for the build status
[22:19:42.993] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:42.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:141:0) after 1m0s
[22:20:43.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:141:0)
[22:20:43.129] Timer tick, asking Buildbucket for the build status
[22:20:43.198] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:43.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:142:0) after 1m0s
[22:21:43.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:142:0)
[22:21:43.320] Timer tick, asking Buildbucket for the build status
[22:21:43.770] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:43.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:143:0) after 1m0s
[22:22:43.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:143:0)
[22:22:43.769] Timer tick, asking Buildbucket for the build status
[22:22:43.992] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:43.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:144:0) after 1m0s
[22:23:44.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:144:0)
[22:23:44.043] Timer tick, asking Buildbucket for the build status
[22:23:44.366] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:44.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:145:0) after 1m0s
[22:24:44.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:145:0)
[22:24:44.369] Timer tick, asking Buildbucket for the build status
[22:24:44.698] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:44.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:146:0) after 1m0s
[22:25:44.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:146:0)
[22:25:44.775] Timer tick, asking Buildbucket for the build status
[22:25:44.934] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:44.934] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:147:0) after 1m0s
[22:26:44.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:147:0)
[22:26:44.945] Timer tick, asking Buildbucket for the build status
[22:26:45.201] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:45.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:148:0) after 1m0s
[22:27:45.222] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:148:0)
[22:27:45.222] Timer tick, asking Buildbucket for the build status
[22:27:45.295] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:45.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:149:0) after 1m0s
[22:28:45.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:149:0)
[22:28:45.340] Timer tick, asking Buildbucket for the build status
[22:28:45.429] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:45.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:150:0) after 1m0s
[22:29:45.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:150:0)
[22:29:45.454] Timer tick, asking Buildbucket for the build status
[22:29:45.628] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:45.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:151:0) after 1m0s
[22:30:45.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:151:0)
[22:30:45.825] Timer tick, asking Buildbucket for the build status
[22:30:45.951] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:45.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:152:0) after 1m0s
[22:31:45.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:152:0)
[22:31:45.982] Timer tick, asking Buildbucket for the build status
[22:31:46.154] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:46.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:153:0) after 1m0s
[22:32:46.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:153:0)
[22:32:46.270] Timer tick, asking Buildbucket for the build status
[22:32:46.378] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:46.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:154:0) after 1m0s
[22:33:46.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:154:0)
[22:33:46.401] Timer tick, asking Buildbucket for the build status
[22:33:46.532] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:46.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:155:0) after 1m0s
[22:34:46.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:155:0)
[22:34:46.602] Timer tick, asking Buildbucket for the build status
[22:34:46.678] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:46.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:156:0) after 1m0s
[22:35:46.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:156:0)
[22:35:46.802] Timer tick, asking Buildbucket for the build status
[22:35:47.702] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:47.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:157:0) after 1m0s
[22:36:47.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:157:0)
[22:36:47.814] Timer tick, asking Buildbucket for the build status
[22:36:48.045] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:48.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:158:0) after 1m0s
[22:37:48.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:158:0)
[22:37:48.079] Timer tick, asking Buildbucket for the build status
[22:37:48.344] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:48.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:159:0) after 1m0s
[22:38:48.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:159:0)
[22:38:48.441] Timer tick, asking Buildbucket for the build status
[22:38:48.725] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:48.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:160:0) after 1m0s
[22:39:48.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:160:0)
[22:39:48.829] Timer tick, asking Buildbucket for the build status
[22:39:48.897] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:48.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:161:0) after 1m0s
[22:40:49.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:161:0)
[22:40:49.641] Timer tick, asking Buildbucket for the build status
[22:40:49.866] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:49.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:162:0) after 1m0s
[22:41:50.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:162:0)
[22:41:50.622] Timer tick, asking Buildbucket for the build status
[22:41:51.033] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:51.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:163:0) after 1m0s
[22:42:51.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:163:0)
[22:42:51.179] Timer tick, asking Buildbucket for the build status
[22:42:51.408] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:51.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:164:0) after 1m0s
[22:43:51.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:164:0)
[22:43:51.522] Timer tick, asking Buildbucket for the build status
[22:43:51.650] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:51.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:165:0) after 1m0s
[22:44:51.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:165:0)
[22:44:51.685] Timer tick, asking Buildbucket for the build status
[22:44:51.886] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:51.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:166:0) after 1m0s
[22:45:51.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:166:0)
[22:45:51.913] Timer tick, asking Buildbucket for the build status
[22:45:52.060] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:52.060] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:167:0) after 1m0s
[22:46:52.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:167:0)
[22:46:52.085] Timer tick, asking Buildbucket for the build status
[22:46:52.172] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:52.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:168:0) after 1m0s
[22:47:52.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:168:0)
[22:47:52.293] Timer tick, asking Buildbucket for the build status
[22:47:52.400] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:52.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:169:0) after 1m0s
[22:48:52.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:169:0)
[22:48:52.847] Timer tick, asking Buildbucket for the build status
[22:48:53.102] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:53.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:170:0) after 1m0s
[22:49:53.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:170:0)
[22:49:53.569] Timer tick, asking Buildbucket for the build status
[22:49:53.912] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:53.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:171:0) after 1m0s
[22:50:53.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:171:0)
[22:50:53.994] Timer tick, asking Buildbucket for the build status
[22:50:54.201] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:54.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:172:0) after 1m0s
[22:51:54.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:172:0)
[22:51:54.762] Timer tick, asking Buildbucket for the build status
[22:51:54.871] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:54.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:173:0) after 1m0s
[22:52:55.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:173:0)
[22:52:55.512] Timer tick, asking Buildbucket for the build status
[22:52:55.651] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:55.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:174:0) after 1m0s
[22:53:55.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:174:0)
[22:53:55.896] Timer tick, asking Buildbucket for the build status
[22:53:56.057] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:56.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:175:0) after 1m0s
[22:54:56.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:175:0)
[22:54:56.232] Timer tick, asking Buildbucket for the build status
[22:54:56.335] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:56.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:176:0) after 1m0s
[22:55:56.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:176:0)
[22:55:56.604] Timer tick, asking Buildbucket for the build status
[22:55:56.905] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:56.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:177:0) after 1m0s
[22:56:57.019] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:177:0)
[22:56:57.019] Timer tick, asking Buildbucket for the build status
[22:56:57.275] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:57.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:178:0) after 1m0s
[22:57:57.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:178:0)
[22:57:57.323] Timer tick, asking Buildbucket for the build status
[22:57:57.516] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:57.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:179:0) after 1m0s
[22:58:57.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:179:0)
[22:58:57.611] Timer tick, asking Buildbucket for the build status
[22:58:58.020] Build 8873411013715614912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:58.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038841083188146976:180:0) after 1m0s
[22:59:28.940] Received PubSub notification, asking Buildbucket for the build status
[22:59:29.157] Build 8873411013715614912: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:59:29.157] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1596063568260365",
    "created_by": "project:infra",
    "created_ts": "1596052839511232",
    "id": "8873411013715614912",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4183.49\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"cbdc3930-9583-48ed-8fef-8ca92abe7f07\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4183.49\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-o8c1\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"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\": [\"5436-adf7f8a\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1596052903640999",
    "status": "COMPLETED",
    "status_changed_ts": "1596063568671895",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038841083188146976",
      "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/8873411013715614912/+/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:4db4fb2b9e9ac010",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1596063568694786",
    "url": "https://ci.chromium.org/b/8873411013715614912",
    "utcnow_ts": "1596063569136897"
  }
}
[22:59:29.157] Invocation finished in 2h58m58.064088559s with status SUCCEEDED