LUCI Scheduler :: infra :: Build From Tarball

Status: FAILED

Triggered by: chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com

Duration: 3 hours

Actions:

Definition (rev ef1333c7bf2cf95d15a0ce92acf83d24bcd6c5ac)

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

Incoming triggers

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

Incoming properties

{
  "version": "82.0.4077.0"
}

Incoming tags

parent_buildername:publish_tarball
user_agent:recipe

Debug log (UTC)

[08:03:44.883] New invocation is queued and will start shortly
[08:03:44.883] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:03:46.348] Starting the invocation (attempt 1)
[08:03:46.416] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:03:46.417] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:03:46.417] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9052203932560647456",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"82.0.4077.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"f8925dc1-92e9-4560-8178-8459b0f52869\",\"title\":\"publish_tarball/0\"}]},\"version\":\"82.0.4077.0\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9052203932560647456",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[08:03:47.892] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1583309026584576",
    "id": "8886773870098926544",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"82.0.4077.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f8925dc1-92e9-4560-8178-8459b0f52869\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"82.0.4077.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1583309026739016",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9052203932560647456",
      "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/8886773870098926544/+/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": "1583309026739115",
    "url": "https://ci.chromium.org/b/8886773870098926544",
    "utcnow_ts": "1583309027884366"
  }
}
[08:03:47.892] Task URL: https://ci.chromium.org/b/8886773870098926544
[08:03:47.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:2:0) after 1m0s
[08:04:47.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:2:0)
[08:04:47.913] Timer tick, asking Buildbucket for the build status
[08:04:49.238] Build 8886773870098926544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:04:49.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:3:0) after 1m0s
[08:05:49.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:3:0)
[08:05:49.400] Timer tick, asking Buildbucket for the build status
[08:05:49.542] Build 8886773870098926544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:05:49.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:4:0) after 1m0s
[08:06:49.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:4:0)
[08:06:49.581] Timer tick, asking Buildbucket for the build status
[08:06:49.690] Build 8886773870098926544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:06:49.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:5:0) after 1m0s
[08:07:49.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:5:0)
[08:07:49.730] Timer tick, asking Buildbucket for the build status
[08:07:50.095] Build 8886773870098926544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:07:50.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:6:0) after 1m0s
[08:08:50.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:6:0)
[08:08:50.143] Timer tick, asking Buildbucket for the build status
[08:08:50.349] Build 8886773870098926544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:08:50.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:7:0) after 1m0s
[08:09:50.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:7:0)
[08:09:50.404] Timer tick, asking Buildbucket for the build status
[08:09:50.571] Build 8886773870098926544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:09:50.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:8:0) after 1m0s
[08:10:50.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:8:0)
[08:10:50.596] Timer tick, asking Buildbucket for the build status
[08:10:50.794] Build 8886773870098926544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:10:50.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:9:0) after 1m0s
[08:11:34.537] Received PubSub notification, asking Buildbucket for the build status
[08:11:34.692] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:50.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:9:0)
[08:11:50.823] Timer tick, asking Buildbucket for the build status
[08:11:50.990] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:50.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:11:0) after 1m0s
[08:12:51.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:11:0)
[08:12:51.198] Timer tick, asking Buildbucket for the build status
[08:12:51.476] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:51.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:12:0) after 1m0s
[08:13:51.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:12:0)
[08:13:51.471] Timer tick, asking Buildbucket for the build status
[08:13:51.671] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:51.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:13:0) after 1m0s
[08:14:51.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:13:0)
[08:14:51.719] Timer tick, asking Buildbucket for the build status
[08:14:51.806] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:51.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:14:0) after 1m0s
[08:15:51.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:14:0)
[08:15:51.862] Timer tick, asking Buildbucket for the build status
[08:15:51.981] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:51.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:15:0) after 1m0s
[08:16:51.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:15:0)
[08:16:51.982] Timer tick, asking Buildbucket for the build status
[08:16:52.136] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:52.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:16:0) after 1m0s
[08:17:52.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:16:0)
[08:17:52.157] Timer tick, asking Buildbucket for the build status
[08:17:52.362] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:52.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:17:0) after 1m0s
[08:18:52.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:17:0)
[08:18:52.523] Timer tick, asking Buildbucket for the build status
[08:18:52.651] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:52.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:18:0) after 1m0s
[08:19:52.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:18:0)
[08:19:52.656] Timer tick, asking Buildbucket for the build status
[08:19:52.758] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:52.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:19:0) after 1m0s
[08:20:52.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:19:0)
[08:20:52.815] Timer tick, asking Buildbucket for the build status
[08:20:52.952] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:52.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:20:0) after 1m0s
[08:21:53.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:20:0)
[08:21:53.049] Timer tick, asking Buildbucket for the build status
[08:21:53.173] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:53.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:21:0) after 1m0s
[08:22:53.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:21:0)
[08:22:53.179] Timer tick, asking Buildbucket for the build status
[08:22:53.286] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:53.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:22:0) after 1m0s
[08:23:53.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:22:0)
[08:23:53.533] Timer tick, asking Buildbucket for the build status
[08:23:53.662] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:53.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:23:0) after 1m0s
[08:24:53.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:23:0)
[08:24:53.834] Timer tick, asking Buildbucket for the build status
[08:24:53.957] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:53.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:24:0) after 1m0s
[08:25:54.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:24:0)
[08:25:54.128] Timer tick, asking Buildbucket for the build status
[08:25:55.880] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:55.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:25:0) after 1m0s
[08:26:55.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:25:0)
[08:26:55.958] Timer tick, asking Buildbucket for the build status
[08:26:56.243] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:56.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:26:0) after 1m0s
[08:27:56.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:26:0)
[08:27:56.316] Timer tick, asking Buildbucket for the build status
[08:27:56.435] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:56.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:27:0) after 1m0s
[08:28:56.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:27:0)
[08:28:56.564] Timer tick, asking Buildbucket for the build status
[08:28:56.708] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:56.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:28:0) after 1m0s
[08:29:56.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:28:0)
[08:29:56.809] Timer tick, asking Buildbucket for the build status
[08:29:56.992] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:56.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:29:0) after 1m0s
[08:30:57.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:29:0)
[08:30:57.084] Timer tick, asking Buildbucket for the build status
[08:30:57.241] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:57.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:30:0) after 1m0s
[08:31:57.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:30:0)
[08:31:57.317] Timer tick, asking Buildbucket for the build status
[08:31:57.430] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:57.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:31:0) after 1m0s
[08:32:57.630] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:31:0)
[08:32:57.630] Timer tick, asking Buildbucket for the build status
[08:32:57.893] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:57.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:32:0) after 1m0s
[08:33:57.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:32:0)
[08:33:57.958] Timer tick, asking Buildbucket for the build status
[08:33:58.251] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:58.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:33:0) after 1m0s
[08:34:58.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:33:0)
[08:34:58.364] Timer tick, asking Buildbucket for the build status
[08:34:58.510] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:58.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:34:0) after 1m0s
[08:35:58.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:34:0)
[08:35:58.533] Timer tick, asking Buildbucket for the build status
[08:35:58.654] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:58.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:35:0) after 1m0s
[08:36:58.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:35:0)
[08:36:58.767] Timer tick, asking Buildbucket for the build status
[08:36:59.162] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:59.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:36:0) after 1m0s
[08:37:59.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:36:0)
[08:37:59.245] Timer tick, asking Buildbucket for the build status
[08:37:59.776] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:59.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:37:0) after 1m0s
[08:38:59.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:37:0)
[08:38:59.895] Timer tick, asking Buildbucket for the build status
[08:39:00.195] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:00.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:38:0) after 1m0s
[08:40:00.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:38:0)
[08:40:00.242] Timer tick, asking Buildbucket for the build status
[08:40:00.420] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:00.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:39:0) after 1m0s
[08:41:00.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:39:0)
[08:41:00.424] Timer tick, asking Buildbucket for the build status
[08:41:00.537] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:00.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:40:0) after 1m0s
[08:42:00.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:40:0)
[08:42:00.610] Timer tick, asking Buildbucket for the build status
[08:42:00.712] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:00.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:41:0) after 1m0s
[08:43:00.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:41:0)
[08:43:00.836] Timer tick, asking Buildbucket for the build status
[08:43:01.015] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:01.015] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:42:0) after 1m0s
[08:44:01.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:42:0)
[08:44:01.073] Timer tick, asking Buildbucket for the build status
[08:44:01.209] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:01.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:43:0) after 1m0s
[08:45:01.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:43:0)
[08:45:01.263] Timer tick, asking Buildbucket for the build status
[08:45:01.392] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:01.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:44:0) after 1m0s
[08:46:01.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:44:0)
[08:46:01.420] Timer tick, asking Buildbucket for the build status
[08:46:01.548] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:01.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:45:0) after 1m0s
[08:47:01.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:45:0)
[08:47:01.665] Timer tick, asking Buildbucket for the build status
[08:47:01.779] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:01.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:46:0) after 1m0s
[08:48:01.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:46:0)
[08:48:01.866] Timer tick, asking Buildbucket for the build status
[08:48:01.989] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:01.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:47:0) after 1m0s
[08:49:02.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:47:0)
[08:49:02.043] Timer tick, asking Buildbucket for the build status
[08:49:02.297] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:02.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:48:0) after 1m0s
[08:50:03.888] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:48:0)
[08:50:03.888] Timer tick, asking Buildbucket for the build status
[08:50:04.101] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:04.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:49:0) after 1m0s
[08:51:04.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:49:0)
[08:51:04.344] Timer tick, asking Buildbucket for the build status
[08:51:04.480] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:04.480] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:50:0) after 1m0s
[08:52:06.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:50:0)
[08:52:06.246] Timer tick, asking Buildbucket for the build status
[08:52:06.341] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:06.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:51:0) after 1m0s
[08:53:06.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:51:0)
[08:53:06.366] Timer tick, asking Buildbucket for the build status
[08:53:06.532] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:06.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:52:0) after 1m0s
[08:54:06.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:52:0)
[08:54:06.625] Timer tick, asking Buildbucket for the build status
[08:54:06.796] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:06.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:53:0) after 1m0s
[08:55:06.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:53:0)
[08:55:06.815] Timer tick, asking Buildbucket for the build status
[08:55:07.119] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:07.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:54:0) after 1m0s
[08:56:07.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:54:0)
[08:56:07.151] Timer tick, asking Buildbucket for the build status
[08:56:07.319] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:07.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:55:0) after 1m0s
[08:57:07.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:55:0)
[08:57:07.370] Timer tick, asking Buildbucket for the build status
[08:57:07.744] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:07.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:56:0) after 1m0s
[08:58:07.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:56:0)
[08:58:07.819] Timer tick, asking Buildbucket for the build status
[08:58:08.238] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:08.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:57:0) after 1m0s
[08:59:08.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:57:0)
[08:59:08.250] Timer tick, asking Buildbucket for the build status
[08:59:08.483] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:08.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:58:0) after 1m0s
[09:00:08.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:58:0)
[09:00:08.660] Timer tick, asking Buildbucket for the build status
[09:00:09.134] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:09.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:59:0) after 1m0s
[09:01:09.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:59:0)
[09:01:09.555] Timer tick, asking Buildbucket for the build status
[09:01:09.715] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:09.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:60:0) after 1m0s
[09:02:09.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:60:0)
[09:02:09.963] Timer tick, asking Buildbucket for the build status
[09:02:10.109] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:10.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:61:0) after 1m0s
[09:03:10.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:61:0)
[09:03:10.289] Timer tick, asking Buildbucket for the build status
[09:03:10.409] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:10.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:62:0) after 1m0s
[09:04:10.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:62:0)
[09:04:10.475] Timer tick, asking Buildbucket for the build status
[09:04:10.620] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:10.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:63:0) after 1m0s
[09:05:10.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:63:0)
[09:05:10.765] Timer tick, asking Buildbucket for the build status
[09:05:10.910] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:10.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:64:0) after 1m0s
[09:06:11.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:64:0)
[09:06:11.011] Timer tick, asking Buildbucket for the build status
[09:06:11.136] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:11.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:65:0) after 1m0s
[09:07:11.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:65:0)
[09:07:11.164] Timer tick, asking Buildbucket for the build status
[09:07:11.269] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:11.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:66:0) after 1m0s
[09:08:11.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:66:0)
[09:08:11.471] Timer tick, asking Buildbucket for the build status
[09:08:11.630] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:11.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:67:0) after 1m0s
[09:09:11.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:67:0)
[09:09:11.635] Timer tick, asking Buildbucket for the build status
[09:09:11.992] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:11.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:68:0) after 1m0s
[09:10:12.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:68:0)
[09:10:12.291] Timer tick, asking Buildbucket for the build status
[09:10:12.403] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:12.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:69:0) after 1m0s
[09:11:12.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:69:0)
[09:11:12.506] Timer tick, asking Buildbucket for the build status
[09:11:12.789] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:12.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:70:0) after 1m0s
[09:12:12.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:70:0)
[09:12:12.937] Timer tick, asking Buildbucket for the build status
[09:12:13.079] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:13.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:71:0) after 1m0s
[09:13:13.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:71:0)
[09:13:13.129] Timer tick, asking Buildbucket for the build status
[09:13:13.684] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:13.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:72:0) after 1m0s
[09:14:13.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:72:0)
[09:14:13.715] Timer tick, asking Buildbucket for the build status
[09:14:13.900] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:13.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:73:0) after 1m0s
[09:15:13.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:73:0)
[09:15:13.965] Timer tick, asking Buildbucket for the build status
[09:15:14.178] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:14.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:74:0) after 1m0s
[09:16:14.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:74:0)
[09:16:14.211] Timer tick, asking Buildbucket for the build status
[09:16:14.336] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:14.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:75:0) after 1m0s
[09:17:14.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:75:0)
[09:17:14.367] Timer tick, asking Buildbucket for the build status
[09:17:14.598] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:14.598] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:76:0) after 1m0s
[09:18:14.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:76:0)
[09:18:14.631] Timer tick, asking Buildbucket for the build status
[09:18:14.790] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:14.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:77:0) after 1m0s
[09:19:14.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:77:0)
[09:19:14.968] Timer tick, asking Buildbucket for the build status
[09:19:15.195] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:15.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:78:0) after 1m0s
[09:20:15.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:78:0)
[09:20:15.323] Timer tick, asking Buildbucket for the build status
[09:20:15.567] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:15.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:79:0) after 1m0s
[09:21:15.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:79:0)
[09:21:15.593] Timer tick, asking Buildbucket for the build status
[09:21:15.751] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:15.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:80:0) after 1m0s
[09:22:15.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:80:0)
[09:22:15.812] Timer tick, asking Buildbucket for the build status
[09:22:15.934] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:15.934] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:81:0) after 1m0s
[09:23:15.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:81:0)
[09:23:15.940] Timer tick, asking Buildbucket for the build status
[09:23:16.143] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:16.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:82:0) after 1m0s
[09:24:16.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:82:0)
[09:24:16.161] Timer tick, asking Buildbucket for the build status
[09:24:16.286] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:16.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:83:0) after 1m0s
[09:25:16.310] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:83:0)
[09:25:16.310] Timer tick, asking Buildbucket for the build status
[09:25:16.428] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:16.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:84:0) after 1m0s
[09:26:16.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:84:0)
[09:26:16.465] Timer tick, asking Buildbucket for the build status
[09:26:16.635] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:16.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:85:0) after 1m0s
[09:27:16.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:85:0)
[09:27:16.778] Timer tick, asking Buildbucket for the build status
[09:27:16.965] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:16.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:86:0) after 1m0s
[09:28:16.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:86:0)
[09:28:16.971] Timer tick, asking Buildbucket for the build status
[09:28:17.082] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:17.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:87:0) after 1m0s
[09:29:17.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:87:0)
[09:29:17.167] Timer tick, asking Buildbucket for the build status
[09:29:17.358] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:17.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:88:0) after 1m0s
[09:30:17.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:88:0)
[09:30:17.423] Timer tick, asking Buildbucket for the build status
[09:30:17.596] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:17.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:89:0) after 1m0s
[09:31:17.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:89:0)
[09:31:17.708] Timer tick, asking Buildbucket for the build status
[09:31:18.161] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:18.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:90:0) after 1m0s
[09:32:18.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:90:0)
[09:32:18.232] Timer tick, asking Buildbucket for the build status
[09:32:18.499] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:18.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:91:0) after 1m0s
[09:33:18.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:91:0)
[09:33:18.544] Timer tick, asking Buildbucket for the build status
[09:33:18.673] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:18.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:92:0) after 1m0s
[09:34:18.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:92:0)
[09:34:18.794] Timer tick, asking Buildbucket for the build status
[09:34:19.260] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:19.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:93:0) after 1m0s
[09:35:19.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:93:0)
[09:35:19.372] Timer tick, asking Buildbucket for the build status
[09:35:19.639] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:19.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:94:0) after 1m0s
[09:36:19.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:94:0)
[09:36:19.762] Timer tick, asking Buildbucket for the build status
[09:36:19.949] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:20.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:95:0) after 1m0s
[09:37:20.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:95:0)
[09:37:20.095] Timer tick, asking Buildbucket for the build status
[09:37:20.264] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:20.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:96:0) after 1m0s
[09:38:20.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:96:0)
[09:38:20.290] Timer tick, asking Buildbucket for the build status
[09:38:20.457] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:20.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:97:0) after 1m0s
[09:39:20.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:97:0)
[09:39:20.537] Timer tick, asking Buildbucket for the build status
[09:39:20.659] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:20.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:98:0) after 1m0s
[09:40:20.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:98:0)
[09:40:20.694] Timer tick, asking Buildbucket for the build status
[09:40:20.833] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:20.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:99:0) after 1m0s
[09:41:20.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:99:0)
[09:41:20.909] Timer tick, asking Buildbucket for the build status
[09:41:21.179] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:21.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:100:0) after 1m0s
[09:42:21.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:100:0)
[09:42:21.212] Timer tick, asking Buildbucket for the build status
[09:42:21.607] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:21.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:101:0) after 1m0s
[09:43:21.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:101:0)
[09:43:21.608] Timer tick, asking Buildbucket for the build status
[09:43:22.271] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:22.271] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:102:0) after 1m0s
[09:44:22.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:102:0)
[09:44:22.315] Timer tick, asking Buildbucket for the build status
[09:44:22.956] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:22.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:103:0) after 1m0s
[09:45:22.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:103:0)
[09:45:22.983] Timer tick, asking Buildbucket for the build status
[09:45:23.256] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:23.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:104:0) after 1m0s
[09:46:23.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:104:0)
[09:46:23.352] Timer tick, asking Buildbucket for the build status
[09:46:23.655] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:23.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:105:0) after 1m0s
[09:47:23.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:105:0)
[09:47:23.740] Timer tick, asking Buildbucket for the build status
[09:47:23.852] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:23.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:106:0) after 1m0s
[09:48:23.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:106:0)
[09:48:23.882] Timer tick, asking Buildbucket for the build status
[09:48:24.276] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:24.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:107:0) after 1m0s
[09:49:24.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:107:0)
[09:49:24.356] Timer tick, asking Buildbucket for the build status
[09:49:24.770] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:24.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:108:0) after 1m0s
[09:50:24.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:108:0)
[09:50:24.796] Timer tick, asking Buildbucket for the build status
[09:50:24.976] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:24.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:109:0) after 1m0s
[09:51:25.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:109:0)
[09:51:25.027] Timer tick, asking Buildbucket for the build status
[09:51:25.281] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:25.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:110:0) after 1m0s
[09:52:25.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:110:0)
[09:52:25.316] Timer tick, asking Buildbucket for the build status
[09:52:25.451] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:25.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:111:0) after 1m0s
[09:53:25.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:111:0)
[09:53:25.478] Timer tick, asking Buildbucket for the build status
[09:53:25.630] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:25.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:112:0) after 1m0s
[09:54:25.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:112:0)
[09:54:25.687] Timer tick, asking Buildbucket for the build status
[09:54:25.801] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:25.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:113:0) after 1m0s
[09:55:25.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:113:0)
[09:55:25.793] Timer tick, asking Buildbucket for the build status
[09:55:26.055] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:26.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:114:0) after 1m0s
[09:56:26.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:114:0)
[09:56:26.044] Timer tick, asking Buildbucket for the build status
[09:56:26.355] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:26.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:115:0) after 1m0s
[09:57:26.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:115:0)
[09:57:26.402] Timer tick, asking Buildbucket for the build status
[09:57:26.538] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:26.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:116:0) after 1m0s
[09:58:26.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:116:0)
[09:58:26.520] Timer tick, asking Buildbucket for the build status
[09:58:26.668] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:26.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:117:0) after 1m0s
[09:59:26.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:117:0)
[09:59:26.676] Timer tick, asking Buildbucket for the build status
[09:59:27.192] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:27.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:118:0) after 1m0s
[10:00:27.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:118:0)
[10:00:27.218] Timer tick, asking Buildbucket for the build status
[10:00:27.478] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:27.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:119:0) after 1m0s
[10:01:27.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:119:0)
[10:01:27.545] Timer tick, asking Buildbucket for the build status
[10:01:27.843] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:27.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:120:0) after 1m0s
[10:02:27.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:120:0)
[10:02:27.836] Timer tick, asking Buildbucket for the build status
[10:02:28.011] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:28.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:121:0) after 1m0s
[10:03:28.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:121:0)
[10:03:28.128] Timer tick, asking Buildbucket for the build status
[10:03:39.054] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:39.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:122:0) after 1m0s
[10:04:39.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:122:0)
[10:04:39.112] Timer tick, asking Buildbucket for the build status
[10:04:39.315] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:39.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:123:0) after 1m0s
[10:05:39.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:123:0)
[10:05:39.416] Timer tick, asking Buildbucket for the build status
[10:05:39.563] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:39.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:124:0) after 1m0s
[10:06:39.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:124:0)
[10:06:39.723] Timer tick, asking Buildbucket for the build status
[10:06:39.921] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:39.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:125:0) after 1m0s
[10:07:39.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:125:0)
[10:07:39.984] Timer tick, asking Buildbucket for the build status
[10:07:40.112] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:40.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:126:0) after 1m0s
[10:08:40.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:126:0)
[10:08:40.208] Timer tick, asking Buildbucket for the build status
[10:08:40.430] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:40.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:127:0) after 1m0s
[10:09:40.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:127:0)
[10:09:40.492] Timer tick, asking Buildbucket for the build status
[10:09:40.625] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:40.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:128:0) after 1m0s
[10:10:40.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:128:0)
[10:10:40.692] Timer tick, asking Buildbucket for the build status
[10:10:40.910] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:40.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:129:0) after 1m0s
[10:11:40.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:129:0)
[10:11:40.936] Timer tick, asking Buildbucket for the build status
[10:11:41.056] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:41.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:130:0) after 1m0s
[10:12:41.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:130:0)
[10:12:41.084] Timer tick, asking Buildbucket for the build status
[10:12:41.380] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:41.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:131:0) after 1m0s
[10:13:41.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:131:0)
[10:13:41.438] Timer tick, asking Buildbucket for the build status
[10:13:41.675] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:41.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:132:0) after 1m0s
[10:14:41.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:132:0)
[10:14:41.689] Timer tick, asking Buildbucket for the build status
[10:14:41.965] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:41.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:133:0) after 1m0s
[10:15:42.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:133:0)
[10:15:42.025] Timer tick, asking Buildbucket for the build status
[10:15:42.500] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:42.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:134:0) after 1m0s
[10:16:42.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:134:0)
[10:16:42.569] Timer tick, asking Buildbucket for the build status
[10:16:42.684] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:42.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:135:0) after 1m0s
[10:17:42.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:135:0)
[10:17:42.759] Timer tick, asking Buildbucket for the build status
[10:17:42.874] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:42.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:136:0) after 1m0s
[10:18:42.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:136:0)
[10:18:42.939] Timer tick, asking Buildbucket for the build status
[10:18:44.022] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:44.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:137:0) after 1m0s
[10:19:44.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:137:0)
[10:19:44.016] Timer tick, asking Buildbucket for the build status
[10:19:44.161] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:44.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:138:0) after 1m0s
[10:20:44.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:138:0)
[10:20:44.313] Timer tick, asking Buildbucket for the build status
[10:20:44.428] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:44.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:139:0) after 1m0s
[10:21:44.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:139:0)
[10:21:44.566] Timer tick, asking Buildbucket for the build status
[10:21:44.784] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:44.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:140:0) after 1m0s
[10:22:44.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:140:0)
[10:22:44.820] Timer tick, asking Buildbucket for the build status
[10:22:44.923] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:44.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:141:0) after 1m0s
[10:23:44.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:141:0)
[10:23:44.996] Timer tick, asking Buildbucket for the build status
[10:23:45.166] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:45.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:142:0) after 1m0s
[10:24:45.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:142:0)
[10:24:45.198] Timer tick, asking Buildbucket for the build status
[10:24:45.524] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:45.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:143:0) after 1m0s
[10:25:45.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:143:0)
[10:25:45.615] Timer tick, asking Buildbucket for the build status
[10:25:45.843] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:45.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:144:0) after 1m0s
[10:26:45.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:144:0)
[10:26:45.959] Timer tick, asking Buildbucket for the build status
[10:26:46.248] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:46.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:145:0) after 1m0s
[10:27:46.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:145:0)
[10:27:46.328] Timer tick, asking Buildbucket for the build status
[10:27:46.453] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:46.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:146:0) after 1m0s
[10:28:46.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:146:0)
[10:28:46.511] Timer tick, asking Buildbucket for the build status
[10:28:46.976] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:46.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:147:0) after 1m0s
[10:29:47.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:147:0)
[10:29:47.027] Timer tick, asking Buildbucket for the build status
[10:29:47.247] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:47.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:148:0) after 1m0s
[10:30:47.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:148:0)
[10:30:47.415] Timer tick, asking Buildbucket for the build status
[10:30:47.554] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:47.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:149:0) after 1m0s
[10:31:47.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:149:0)
[10:31:47.693] Timer tick, asking Buildbucket for the build status
[10:31:47.814] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:47.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:150:0) after 1m0s
[10:32:47.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:150:0)
[10:32:47.902] Timer tick, asking Buildbucket for the build status
[10:32:48.032] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:48.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:151:0) after 1m0s
[10:33:48.130] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:151:0)
[10:33:48.130] Timer tick, asking Buildbucket for the build status
[10:33:48.240] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:48.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:152:0) after 1m0s
[10:34:48.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:152:0)
[10:34:48.319] Timer tick, asking Buildbucket for the build status
[10:34:48.429] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:48.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:153:0) after 1m0s
[10:35:48.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:153:0)
[10:35:48.550] Timer tick, asking Buildbucket for the build status
[10:35:48.665] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:48.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:154:0) after 1m0s
[10:36:48.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:154:0)
[10:36:48.816] Timer tick, asking Buildbucket for the build status
[10:36:48.954] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:48.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:155:0) after 1m0s
[10:37:48.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:155:0)
[10:37:48.972] Timer tick, asking Buildbucket for the build status
[10:37:49.125] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:49.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:156:0) after 1m0s
[10:38:49.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:156:0)
[10:38:49.227] Timer tick, asking Buildbucket for the build status
[10:38:49.338] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:49.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:157:0) after 1m0s
[10:39:49.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:157:0)
[10:39:49.411] Timer tick, asking Buildbucket for the build status
[10:39:49.606] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:49.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:158:0) after 1m0s
[10:40:49.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:158:0)
[10:40:49.637] Timer tick, asking Buildbucket for the build status
[10:40:49.758] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:49.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:159:0) after 1m0s
[10:41:49.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:159:0)
[10:41:49.808] Timer tick, asking Buildbucket for the build status
[10:41:49.922] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:49.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:160:0) after 1m0s
[10:42:50.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:160:0)
[10:42:50.041] Timer tick, asking Buildbucket for the build status
[10:42:50.207] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:50.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:161:0) after 1m0s
[10:43:50.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:161:0)
[10:43:50.298] Timer tick, asking Buildbucket for the build status
[10:43:50.611] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:50.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:162:0) after 1m0s
[10:44:50.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:162:0)
[10:44:50.601] Timer tick, asking Buildbucket for the build status
[10:44:50.720] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:50.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:163:0) after 1m0s
[10:45:50.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:163:0)
[10:45:50.743] Timer tick, asking Buildbucket for the build status
[10:45:51.237] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:51.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:164:0) after 1m0s
[10:46:51.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:164:0)
[10:46:51.262] Timer tick, asking Buildbucket for the build status
[10:46:51.412] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:51.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:165:0) after 1m0s
[10:47:51.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:165:0)
[10:47:51.442] Timer tick, asking Buildbucket for the build status
[10:47:51.640] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:51.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:166:0) after 1m0s
[10:48:51.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:166:0)
[10:48:51.730] Timer tick, asking Buildbucket for the build status
[10:48:51.924] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:51.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:167:0) after 1m0s
[10:49:51.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:167:0)
[10:49:51.982] Timer tick, asking Buildbucket for the build status
[10:49:52.155] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:52.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:168:0) after 1m0s
[10:50:52.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:168:0)
[10:50:52.285] Timer tick, asking Buildbucket for the build status
[10:50:52.428] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:52.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:169:0) after 1m0s
[10:51:52.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:169:0)
[10:51:52.474] Timer tick, asking Buildbucket for the build status
[10:51:52.855] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:52.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:170:0) after 1m0s
[10:52:52.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:170:0)
[10:52:52.915] Timer tick, asking Buildbucket for the build status
[10:52:53.422] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:53.422] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:171:0) after 1m0s
[10:53:53.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:171:0)
[10:53:53.442] Timer tick, asking Buildbucket for the build status
[10:53:53.589] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:53.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:172:0) after 1m0s
[10:54:53.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:172:0)
[10:54:53.658] Timer tick, asking Buildbucket for the build status
[10:54:53.755] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:53.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:173:0) after 1m0s
[10:55:53.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:173:0)
[10:55:53.789] Timer tick, asking Buildbucket for the build status
[10:55:53.964] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:53.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:174:0) after 1m0s
[10:56:54.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:174:0)
[10:56:54.038] Timer tick, asking Buildbucket for the build status
[10:56:54.156] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:54.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:175:0) after 1m0s
[10:57:54.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:175:0)
[10:57:54.201] Timer tick, asking Buildbucket for the build status
[10:57:54.590] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:54.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:176:0) after 1m0s
[10:58:54.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:176:0)
[10:58:54.646] Timer tick, asking Buildbucket for the build status
[10:58:54.781] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:54.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:177:0) after 1m0s
[10:59:54.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:177:0)
[10:59:54.822] Timer tick, asking Buildbucket for the build status
[10:59:54.911] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:54.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:178:0) after 1m0s
[11:00:55.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:178:0)
[11:00:55.016] Timer tick, asking Buildbucket for the build status
[11:00:55.171] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:55.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:179:0) after 1m0s
[11:01:55.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:179:0)
[11:01:55.248] Timer tick, asking Buildbucket for the build status
[11:01:55.353] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:55.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:180:0) after 1m0s
[11:02:55.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:180:0)
[11:02:55.407] Timer tick, asking Buildbucket for the build status
[11:02:55.777] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:55.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:181:0) after 1m0s
[11:03:55.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:181:0)
[11:03:55.823] Timer tick, asking Buildbucket for the build status
[11:03:56.183] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:56.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:182:0) after 1m0s
[11:04:56.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:182:0)
[11:04:56.323] Timer tick, asking Buildbucket for the build status
[11:04:56.557] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:56.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:183:0) after 1m0s
[11:05:56.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:183:0)
[11:05:56.677] Timer tick, asking Buildbucket for the build status
[11:05:56.857] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:56.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:184:0) after 1m0s
[11:06:56.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:184:0)
[11:06:56.973] Timer tick, asking Buildbucket for the build status
[11:06:57.082] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:57.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:185:0) after 1m0s
[11:07:57.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:185:0)
[11:07:57.094] Timer tick, asking Buildbucket for the build status
[11:07:57.453] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:57.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:186:0) after 1m0s
[11:08:57.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:186:0)
[11:08:57.514] Timer tick, asking Buildbucket for the build status
[11:08:57.677] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:57.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:187:0) after 1m0s
[11:09:57.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:187:0)
[11:09:57.752] Timer tick, asking Buildbucket for the build status
[11:09:57.973] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:57.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:188:0) after 1m0s
[11:10:58.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:188:0)
[11:10:58.060] Timer tick, asking Buildbucket for the build status
[11:10:58.332] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:58.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:189:0) after 1m0s
[11:11:58.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:189:0)
[11:11:58.526] Timer tick, asking Buildbucket for the build status
[11:11:59.064] Build 8886773870098926544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:59.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9052203932560647456:190:0) after 1m0s
[11:12:12.504] Received PubSub notification, asking Buildbucket for the build status
[11:12:12.591] Build 8886773870098926544: status "COMPLETED", result "CANCELED", failure_reason "", cancelation_reason "TIMEOUT"
[11:12:12.591] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "cancelation_reason": "TIMEOUT",
    "completed_ts": "1583320331441881",
    "created_by": "project:infra",
    "created_ts": "1583309026584576",
    "id": "8886773870098926544",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"82.0.4077.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f8925dc1-92e9-4560-8178-8459b0f52869\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"82.0.4077.0\"}}",
    "project": "infra",
    "result": "CANCELED",
    "result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"82.0.4077.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f8925dc1-92e9-4560-8178-8459b0f52869\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-6tg1\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"82.0.4077.0\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"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-6tg1\"], \"image\": [\"chrome-xenial-20030100-2bddf837f90\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4851-268d16b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1583309492725720",
    "status": "COMPLETED",
    "status_changed_ts": "1583320331999410",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9052203932560647456",
      "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/8886773870098926544/+/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:4abd64040e738b10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1583320332084630",
    "url": "https://ci.chromium.org/b/8886773870098926544",
    "utcnow_ts": "1583320332583261"
  }
}
[11:12:12.591] Invocation finished in 3h8m27.738880126s with status FAILED