LUCI Scheduler :: infra :: Build From Tarball

Status: SUCCEEDED

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

Incoming tags

parent_buildername:publish_tarball
user_agent:recipe

Debug log (UTC)

[13:29:26.214] New invocation is queued and will start shortly
[13:29:26.214] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[13:29:27.321] Starting the invocation (attempt 1)
[13:29:27.357] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:29:27.357] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:29:27.357] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9048287772420764320",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"84.0.4115.5\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"eed620d7-d772-4e8b-b519-52577a200693\",\"title\":\"publish_tarball/0\"}]},\"version\":\"84.0.4115.5\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9048287772420764320",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[13:29:30.223] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "created_by": "project:infra",
    "created_ts": "1587043767679357",
    "id": "8882857710220903920",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4115.5\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"eed620d7-d772-4e8b-b519-52577a200693\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4115.5\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1587043769364290",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9048287772420764320",
      "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/8882857710220903920/+/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": "1587043769364427",
    "url": "https://ci.chromium.org/b/8882857710220903920",
    "utcnow_ts": "1587043770088017"
  }
}
[13:29:30.223] Task URL: https://ci.chromium.org/b/8882857710220903920
[13:29:30.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:2:0) after 1m0s
[13:30:30.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:2:0)
[13:30:30.340] Timer tick, asking Buildbucket for the build status
[13:30:30.507] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:30:30.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:3:0) after 1m0s
[13:31:30.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:3:0)
[13:31:30.652] Timer tick, asking Buildbucket for the build status
[13:31:31.083] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:31:31.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:4:0) after 1m0s
[13:32:31.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:4:0)
[13:32:31.157] Timer tick, asking Buildbucket for the build status
[13:32:31.300] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:32:31.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:5:0) after 1m0s
[13:33:31.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:5:0)
[13:33:31.382] Timer tick, asking Buildbucket for the build status
[13:33:31.548] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:33:31.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:6:0) after 1m0s
[13:34:31.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:6:0)
[13:34:31.682] Timer tick, asking Buildbucket for the build status
[13:34:32.434] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:34:32.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:7:0) after 1m0s
[13:35:32.491] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:7:0)
[13:35:32.491] Timer tick, asking Buildbucket for the build status
[13:35:32.612] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:35:32.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:8:0) after 1m0s
[13:36:32.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:8:0)
[13:36:32.649] Timer tick, asking Buildbucket for the build status
[13:36:32.902] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:36:32.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:9:0) after 1m0s
[13:37:32.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:9:0)
[13:37:32.956] Timer tick, asking Buildbucket for the build status
[13:37:33.314] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:37:33.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:10:0) after 1m0s
[13:38:33.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:10:0)
[13:38:33.367] Timer tick, asking Buildbucket for the build status
[13:38:33.505] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:38:33.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:11:0) after 1m0s
[13:39:33.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:11:0)
[13:39:33.559] Timer tick, asking Buildbucket for the build status
[13:39:34.525] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:39:34.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:12:0) after 1m0s
[13:40:34.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:12:0)
[13:40:34.573] Timer tick, asking Buildbucket for the build status
[13:40:34.800] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:40:34.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:13:0) after 1m0s
[13:41:34.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:13:0)
[13:41:34.845] Timer tick, asking Buildbucket for the build status
[13:41:35.067] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:41:35.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:14:0) after 1m0s
[13:42:35.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:14:0)
[13:42:35.128] Timer tick, asking Buildbucket for the build status
[13:42:35.252] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:42:35.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:15:0) after 1m0s
[13:43:35.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:15:0)
[13:43:35.278] Timer tick, asking Buildbucket for the build status
[13:43:35.469] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:43:35.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:16:0) after 1m0s
[13:44:35.491] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:16:0)
[13:44:35.491] Timer tick, asking Buildbucket for the build status
[13:44:38.248] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:44:38.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:17:0) after 1m0s
[13:45:38.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:17:0)
[13:45:38.285] Timer tick, asking Buildbucket for the build status
[13:45:38.623] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:45:38.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:18:0) after 1m0s
[13:46:38.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:18:0)
[13:46:38.660] Timer tick, asking Buildbucket for the build status
[13:46:38.794] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:46:38.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:19:0) after 1m0s
[13:47:38.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:19:0)
[13:47:38.804] Timer tick, asking Buildbucket for the build status
[13:47:39.418] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:47:39.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:20:0) after 1m0s
[13:48:39.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:20:0)
[13:48:39.448] Timer tick, asking Buildbucket for the build status
[13:48:39.576] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:48:39.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:21:0) after 1m0s
[13:49:39.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:21:0)
[13:49:39.613] Timer tick, asking Buildbucket for the build status
[13:49:41.172] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:49:41.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:22:0) after 1m0s
[13:50:41.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:22:0)
[13:50:41.189] Timer tick, asking Buildbucket for the build status
[13:50:41.436] Build 8882857710220903920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:50:41.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:23:0) after 1m0s
[13:50:59.699] Received PubSub notification, asking Buildbucket for the build status
[13:50:59.952] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:41.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:23:0)
[13:51:41.414] Timer tick, asking Buildbucket for the build status
[13:51:41.821] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:41.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:25:0) after 1m0s
[13:52:41.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:25:0)
[13:52:41.859] Timer tick, asking Buildbucket for the build status
[13:52:42.142] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:42.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:26:0) after 1m0s
[13:53:42.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:26:0)
[13:53:42.163] Timer tick, asking Buildbucket for the build status
[13:53:42.533] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:42.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:27:0) after 1m0s
[13:54:42.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:27:0)
[13:54:42.572] Timer tick, asking Buildbucket for the build status
[13:54:44.497] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:44.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:28:0) after 1m0s
[13:55:44.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:28:0)
[13:55:44.535] Timer tick, asking Buildbucket for the build status
[13:55:44.672] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:44.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:29:0) after 1m0s
[13:56:44.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:29:0)
[13:56:44.702] Timer tick, asking Buildbucket for the build status
[13:56:44.954] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:44.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:30:0) after 1m0s
[13:57:45.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:30:0)
[13:57:45.011] Timer tick, asking Buildbucket for the build status
[13:57:45.262] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:45.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:31:0) after 1m0s
[13:58:45.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:31:0)
[13:58:45.268] Timer tick, asking Buildbucket for the build status
[13:58:45.675] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:45.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:32:0) after 1m0s
[13:59:45.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:32:0)
[13:59:45.695] Timer tick, asking Buildbucket for the build status
[13:59:50.436] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:50.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:33:0) after 1m0s
[14:00:50.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:33:0)
[14:00:50.411] Timer tick, asking Buildbucket for the build status
[14:00:50.565] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:50.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:34:0) after 1m0s
[14:01:50.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:34:0)
[14:01:50.588] Timer tick, asking Buildbucket for the build status
[14:01:50.764] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:50.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:35:0) after 1m0s
[14:02:50.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:35:0)
[14:02:50.804] Timer tick, asking Buildbucket for the build status
[14:02:51.184] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:51.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:36:0) after 1m0s
[14:03:51.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:36:0)
[14:03:51.241] Timer tick, asking Buildbucket for the build status
[14:03:51.371] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:51.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:37:0) after 1m0s
[14:04:51.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:37:0)
[14:04:51.392] Timer tick, asking Buildbucket for the build status
[14:04:51.887] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:51.887] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:38:0) after 1m0s
[14:05:51.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:38:0)
[14:05:51.905] Timer tick, asking Buildbucket for the build status
[14:05:52.040] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:52.040] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:39:0) after 1m0s
[14:06:52.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:39:0)
[14:06:52.077] Timer tick, asking Buildbucket for the build status
[14:06:52.204] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:52.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:40:0) after 1m0s
[14:07:52.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:40:0)
[14:07:52.259] Timer tick, asking Buildbucket for the build status
[14:07:52.371] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:52.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:41:0) after 1m0s
[14:08:52.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:41:0)
[14:08:52.398] Timer tick, asking Buildbucket for the build status
[14:08:52.595] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:52.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:42:0) after 1m0s
[14:09:52.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:42:0)
[14:09:52.641] Timer tick, asking Buildbucket for the build status
[14:09:56.340] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:56.340] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:43:0) after 1m0s
[14:10:56.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:43:0)
[14:10:56.371] Timer tick, asking Buildbucket for the build status
[14:10:56.525] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:56.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:44:0) after 1m0s
[14:11:56.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:44:0)
[14:11:56.592] Timer tick, asking Buildbucket for the build status
[14:11:56.744] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:56.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:45:0) after 1m0s
[14:12:56.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:45:0)
[14:12:56.730] Timer tick, asking Buildbucket for the build status
[14:12:57.074] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:57.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:46:0) after 1m0s
[14:13:57.072] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:46:0)
[14:13:57.072] Timer tick, asking Buildbucket for the build status
[14:13:57.326] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:57.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:47:0) after 1m0s
[14:14:57.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:47:0)
[14:14:57.357] Timer tick, asking Buildbucket for the build status
[14:14:58.009] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:58.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:48:0) after 1m0s
[14:15:58.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:48:0)
[14:15:58.043] Timer tick, asking Buildbucket for the build status
[14:15:58.417] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:58.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:49:0) after 1m0s
[14:16:58.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:49:0)
[14:16:58.490] Timer tick, asking Buildbucket for the build status
[14:16:58.641] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:58.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:50:0) after 1m0s
[14:17:58.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:50:0)
[14:17:58.699] Timer tick, asking Buildbucket for the build status
[14:17:58.856] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:58.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:51:0) after 1m0s
[14:18:58.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:51:0)
[14:18:58.881] Timer tick, asking Buildbucket for the build status
[14:18:59.103] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:59.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:52:0) after 1m0s
[14:19:59.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:52:0)
[14:19:59.154] Timer tick, asking Buildbucket for the build status
[14:19:59.729] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:59.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:53:0) after 1m0s
[14:20:59.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:53:0)
[14:20:59.783] Timer tick, asking Buildbucket for the build status
[14:20:59.964] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:59.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:54:0) after 1m0s
[14:21:59.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:54:0)
[14:21:59.996] Timer tick, asking Buildbucket for the build status
[14:22:00.292] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:00.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:55:0) after 1m0s
[14:23:00.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:55:0)
[14:23:00.316] Timer tick, asking Buildbucket for the build status
[14:23:00.478] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:00.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:56:0) after 1m0s
[14:24:00.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:56:0)
[14:24:00.547] Timer tick, asking Buildbucket for the build status
[14:24:00.782] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:00.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:57:0) after 1m0s
[14:25:00.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:57:0)
[14:25:00.814] Timer tick, asking Buildbucket for the build status
[14:25:01.336] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:01.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:58:0) after 1m0s
[14:26:01.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:58:0)
[14:26:01.678] Timer tick, asking Buildbucket for the build status
[14:26:01.836] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:01.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:59:0) after 1m0s
[14:27:01.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:59:0)
[14:27:01.911] Timer tick, asking Buildbucket for the build status
[14:27:02.221] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:02.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:60:0) after 1m0s
[14:28:02.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:60:0)
[14:28:02.286] Timer tick, asking Buildbucket for the build status
[14:28:02.677] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:02.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:61:0) after 1m0s
[14:29:02.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:61:0)
[14:29:02.762] Timer tick, asking Buildbucket for the build status
[14:29:03.378] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:03.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:62:0) after 1m0s
[14:30:03.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:62:0)
[14:30:03.416] Timer tick, asking Buildbucket for the build status
[14:30:04.564] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:04.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:63:0) after 1m0s
[14:31:04.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:63:0)
[14:31:04.653] Timer tick, asking Buildbucket for the build status
[14:31:04.860] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:04.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:64:0) after 1m0s
[14:32:05.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:64:0)
[14:32:05.119] Timer tick, asking Buildbucket for the build status
[14:32:05.295] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:05.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:65:0) after 1m0s
[14:33:05.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:65:0)
[14:33:05.359] Timer tick, asking Buildbucket for the build status
[14:33:05.571] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:05.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:66:0) after 1m0s
[14:34:05.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:66:0)
[14:34:05.628] Timer tick, asking Buildbucket for the build status
[14:34:05.902] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:05.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:67:0) after 1m0s
[14:35:05.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:67:0)
[14:35:05.887] Timer tick, asking Buildbucket for the build status
[14:35:06.096] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:06.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:68:0) after 1m0s
[14:36:06.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:68:0)
[14:36:06.156] Timer tick, asking Buildbucket for the build status
[14:36:06.274] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:06.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:69:0) after 1m0s
[14:37:06.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:69:0)
[14:37:06.377] Timer tick, asking Buildbucket for the build status
[14:37:08.313] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:08.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:70:0) after 1m0s
[14:38:08.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:70:0)
[14:38:08.349] Timer tick, asking Buildbucket for the build status
[14:38:08.474] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:08.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:71:0) after 1m0s
[14:39:08.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:71:0)
[14:39:08.513] Timer tick, asking Buildbucket for the build status
[14:39:08.738] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:08.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:72:0) after 1m0s
[14:40:08.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:72:0)
[14:40:08.762] Timer tick, asking Buildbucket for the build status
[14:40:09.118] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:09.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:73:0) after 1m0s
[14:41:09.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:73:0)
[14:41:09.296] Timer tick, asking Buildbucket for the build status
[14:41:09.434] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:09.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:74:0) after 1m0s
[14:42:09.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:74:0)
[14:42:09.508] Timer tick, asking Buildbucket for the build status
[14:42:09.698] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:09.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:75:0) after 1m0s
[14:43:09.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:75:0)
[14:43:09.811] Timer tick, asking Buildbucket for the build status
[14:43:09.964] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:09.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:76:0) after 1m0s
[14:44:10.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:76:0)
[14:44:10.135] Timer tick, asking Buildbucket for the build status
[14:44:10.365] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:10.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:77:0) after 1m0s
[14:45:10.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:77:0)
[14:45:10.435] Timer tick, asking Buildbucket for the build status
[14:45:10.904] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:10.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:78:0) after 1m0s
[14:46:10.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:78:0)
[14:46:10.983] Timer tick, asking Buildbucket for the build status
[14:46:11.127] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:11.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:79:0) after 1m0s
[14:47:11.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:79:0)
[14:47:11.183] Timer tick, asking Buildbucket for the build status
[14:47:11.423] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:11.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:80:0) after 1m0s
[14:48:11.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:80:0)
[14:48:11.581] Timer tick, asking Buildbucket for the build status
[14:48:12.214] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:12.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:81:0) after 1m0s
[14:49:12.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:81:0)
[14:49:12.283] Timer tick, asking Buildbucket for the build status
[14:49:12.461] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:12.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:82:0) after 1m0s
[14:50:12.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:82:0)
[14:50:12.570] Timer tick, asking Buildbucket for the build status
[14:50:12.756] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:12.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:83:0) after 1m0s
[14:51:12.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:83:0)
[14:51:12.784] Timer tick, asking Buildbucket for the build status
[14:51:12.915] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:12.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:84:0) after 1m0s
[14:52:12.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:84:0)
[14:52:12.963] Timer tick, asking Buildbucket for the build status
[14:52:13.087] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:13.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:85:0) after 1m0s
[14:53:13.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:85:0)
[14:53:13.139] Timer tick, asking Buildbucket for the build status
[14:53:13.264] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:13.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:86:0) after 1m0s
[14:54:13.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:86:0)
[14:54:13.283] Timer tick, asking Buildbucket for the build status
[14:54:13.510] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:13.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:87:0) after 1m0s
[14:55:13.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:87:0)
[14:55:13.559] Timer tick, asking Buildbucket for the build status
[14:55:13.705] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:13.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:88:0) after 1m0s
[14:56:13.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:88:0)
[14:56:13.747] Timer tick, asking Buildbucket for the build status
[14:56:13.889] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:13.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:89:0) after 1m0s
[14:57:13.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:89:0)
[14:57:13.949] Timer tick, asking Buildbucket for the build status
[14:57:14.628] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:14.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:90:0) after 1m0s
[14:58:14.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:90:0)
[14:58:14.604] Timer tick, asking Buildbucket for the build status
[14:58:14.803] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:14.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:91:0) after 1m0s
[14:59:14.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:91:0)
[14:59:14.876] Timer tick, asking Buildbucket for the build status
[14:59:15.044] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:15.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:92:0) after 1m0s
[15:00:15.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:92:0)
[15:00:15.266] Timer tick, asking Buildbucket for the build status
[15:00:15.674] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:15.674] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:93:0) after 1m0s
[15:01:16.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:93:0)
[15:01:16.245] Timer tick, asking Buildbucket for the build status
[15:01:16.495] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:16.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:94:0) after 1m0s
[15:02:16.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:94:0)
[15:02:16.543] Timer tick, asking Buildbucket for the build status
[15:02:16.812] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:16.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:95:0) after 1m0s
[15:03:16.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:95:0)
[15:03:16.837] Timer tick, asking Buildbucket for the build status
[15:03:17.032] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:17.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:96:0) after 1m0s
[15:04:17.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:96:0)
[15:04:17.132] Timer tick, asking Buildbucket for the build status
[15:04:17.889] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:17.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:97:0) after 1m0s
[15:05:18.019] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:97:0)
[15:05:18.019] Timer tick, asking Buildbucket for the build status
[15:05:18.498] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:18.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:98:0) after 1m0s
[15:06:18.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:98:0)
[15:06:18.533] Timer tick, asking Buildbucket for the build status
[15:06:18.725] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:18.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:99:0) after 1m0s
[15:07:18.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:99:0)
[15:07:18.806] Timer tick, asking Buildbucket for the build status
[15:07:19.155] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:19.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:100:0) after 1m0s
[15:08:19.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:100:0)
[15:08:19.200] Timer tick, asking Buildbucket for the build status
[15:08:19.421] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:19.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:101:0) after 1m0s
[15:09:19.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:101:0)
[15:09:19.551] Timer tick, asking Buildbucket for the build status
[15:09:20.046] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:20.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:102:0) after 1m0s
[15:10:20.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:102:0)
[15:10:20.235] Timer tick, asking Buildbucket for the build status
[15:10:20.628] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:20.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:103:0) after 1m0s
[15:11:20.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:103:0)
[15:11:20.748] Timer tick, asking Buildbucket for the build status
[15:11:20.943] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:20.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:104:0) after 1m0s
[15:12:20.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:104:0)
[15:12:20.957] Timer tick, asking Buildbucket for the build status
[15:12:21.412] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:21.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:105:0) after 1m0s
[15:13:21.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:105:0)
[15:13:21.447] Timer tick, asking Buildbucket for the build status
[15:13:21.599] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:21.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:106:0) after 1m0s
[15:14:21.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:106:0)
[15:14:21.672] Timer tick, asking Buildbucket for the build status
[15:14:21.822] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:21.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:107:0) after 1m0s
[15:15:21.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:107:0)
[15:15:21.988] Timer tick, asking Buildbucket for the build status
[15:15:22.168] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:22.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:108:0) after 1m0s
[15:16:22.207] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:108:0)
[15:16:22.207] Timer tick, asking Buildbucket for the build status
[15:16:22.362] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:22.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:109:0) after 1m0s
[15:17:22.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:109:0)
[15:17:22.428] Timer tick, asking Buildbucket for the build status
[15:17:22.648] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:22.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:110:0) after 1m0s
[15:18:22.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:110:0)
[15:18:22.729] Timer tick, asking Buildbucket for the build status
[15:18:22.896] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:22.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:111:0) after 1m0s
[15:19:23.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:111:0)
[15:19:23.000] Timer tick, asking Buildbucket for the build status
[15:19:24.144] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:24.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:112:0) after 1m0s
[15:20:24.171] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:112:0)
[15:20:24.171] Timer tick, asking Buildbucket for the build status
[15:20:24.321] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:24.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:113:0) after 1m0s
[15:21:24.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:113:0)
[15:21:24.347] Timer tick, asking Buildbucket for the build status
[15:21:24.572] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:24.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:114:0) after 1m0s
[15:22:24.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:114:0)
[15:22:24.688] Timer tick, asking Buildbucket for the build status
[15:22:25.044] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:25.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:115:0) after 1m0s
[15:23:25.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:115:0)
[15:23:25.208] Timer tick, asking Buildbucket for the build status
[15:23:25.336] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:25.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:116:0) after 1m0s
[15:24:25.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:116:0)
[15:24:25.464] Timer tick, asking Buildbucket for the build status
[15:24:25.882] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:25.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:117:0) after 1m0s
[15:25:26.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:117:0)
[15:25:26.094] Timer tick, asking Buildbucket for the build status
[15:25:26.235] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:26.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:118:0) after 1m0s
[15:26:26.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:118:0)
[15:26:26.427] Timer tick, asking Buildbucket for the build status
[15:26:26.625] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:26.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:119:0) after 1m0s
[15:27:26.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:119:0)
[15:27:26.670] Timer tick, asking Buildbucket for the build status
[15:27:26.799] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:26.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:120:0) after 1m0s
[15:28:27.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:120:0)
[15:28:27.096] Timer tick, asking Buildbucket for the build status
[15:28:27.232] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:27.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:121:0) after 1m0s
[15:29:27.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:121:0)
[15:29:27.405] Timer tick, asking Buildbucket for the build status
[15:29:27.771] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:27.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:122:0) after 1m0s
[15:30:27.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:122:0)
[15:30:27.940] Timer tick, asking Buildbucket for the build status
[15:30:28.258] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:28.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:123:0) after 1m0s
[15:31:28.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:123:0)
[15:31:28.352] Timer tick, asking Buildbucket for the build status
[15:31:28.585] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:28.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:124:0) after 1m0s
[15:32:28.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:124:0)
[15:32:28.761] Timer tick, asking Buildbucket for the build status
[15:32:29.290] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:29.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:125:0) after 1m0s
[15:33:29.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:125:0)
[15:33:29.328] Timer tick, asking Buildbucket for the build status
[15:33:29.462] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:29.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:126:0) after 1m0s
[15:34:29.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:126:0)
[15:34:29.627] Timer tick, asking Buildbucket for the build status
[15:34:30.007] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:30.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:127:0) after 1m0s
[15:35:30.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:127:0)
[15:35:30.218] Timer tick, asking Buildbucket for the build status
[15:35:30.367] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:30.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:128:0) after 1m0s
[15:36:31.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:128:0)
[15:36:31.312] Timer tick, asking Buildbucket for the build status
[15:36:31.590] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:31.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:129:0) after 1m0s
[15:37:31.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:129:0)
[15:37:31.811] Timer tick, asking Buildbucket for the build status
[15:37:32.307] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:32.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:130:0) after 1m0s
[15:38:32.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:130:0)
[15:38:32.485] Timer tick, asking Buildbucket for the build status
[15:38:32.859] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:32.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:131:0) after 1m0s
[15:39:33.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:131:0)
[15:39:33.056] Timer tick, asking Buildbucket for the build status
[15:39:35.752] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:35.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:132:0) after 1m0s
[15:40:35.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:132:0)
[15:40:35.832] Timer tick, asking Buildbucket for the build status
[15:40:36.039] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:36.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:133:0) after 1m0s
[15:41:36.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:133:0)
[15:41:36.091] Timer tick, asking Buildbucket for the build status
[15:41:36.231] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:36.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:134:0) after 1m0s
[15:42:36.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:134:0)
[15:42:36.275] Timer tick, asking Buildbucket for the build status
[15:42:36.439] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:36.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:135:0) after 1m0s
[15:43:36.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:135:0)
[15:43:36.476] Timer tick, asking Buildbucket for the build status
[15:43:36.615] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:36.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:136:0) after 1m0s
[15:44:36.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:136:0)
[15:44:36.675] Timer tick, asking Buildbucket for the build status
[15:44:37.591] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:37.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:137:0) after 1m0s
[15:45:37.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:137:0)
[15:45:37.671] Timer tick, asking Buildbucket for the build status
[15:45:37.812] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:37.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:138:0) after 1m0s
[15:46:37.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:138:0)
[15:46:37.886] Timer tick, asking Buildbucket for the build status
[15:46:38.195] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:38.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:139:0) after 1m0s
[15:47:38.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:139:0)
[15:47:38.308] Timer tick, asking Buildbucket for the build status
[15:47:38.503] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:38.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:140:0) after 1m0s
[15:48:38.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:140:0)
[15:48:38.573] Timer tick, asking Buildbucket for the build status
[15:48:38.779] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:38.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:141:0) after 1m0s
[15:49:38.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:141:0)
[15:49:38.991] Timer tick, asking Buildbucket for the build status
[15:49:42.314] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:42.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:142:0) after 1m0s
[15:50:42.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:142:0)
[15:50:42.334] Timer tick, asking Buildbucket for the build status
[15:50:42.897] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:42.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:143:0) after 1m0s
[15:51:42.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:143:0)
[15:51:42.935] Timer tick, asking Buildbucket for the build status
[15:51:43.113] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:43.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:144:0) after 1m0s
[15:52:43.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:144:0)
[15:52:43.166] Timer tick, asking Buildbucket for the build status
[15:52:43.362] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:43.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:145:0) after 1m0s
[15:53:43.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:145:0)
[15:53:43.423] Timer tick, asking Buildbucket for the build status
[15:53:43.673] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:43.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:146:0) after 1m0s
[15:54:43.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:146:0)
[15:54:43.762] Timer tick, asking Buildbucket for the build status
[15:54:49.438] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:49.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:147:0) after 1m0s
[15:55:49.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:147:0)
[15:55:49.427] Timer tick, asking Buildbucket for the build status
[15:55:49.612] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:49.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:148:0) after 1m0s
[15:56:49.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:148:0)
[15:56:49.676] Timer tick, asking Buildbucket for the build status
[15:56:49.849] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:49.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:149:0) after 1m0s
[15:57:49.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:149:0)
[15:57:49.904] Timer tick, asking Buildbucket for the build status
[15:57:50.126] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:50.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:150:0) after 1m0s
[15:58:50.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:150:0)
[15:58:50.159] Timer tick, asking Buildbucket for the build status
[15:58:50.399] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:50.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:151:0) after 1m0s
[15:59:50.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:151:0)
[15:59:50.459] Timer tick, asking Buildbucket for the build status
[15:59:51.369] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:51.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:152:0) after 1m0s
[16:00:51.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:152:0)
[16:00:51.416] Timer tick, asking Buildbucket for the build status
[16:00:51.567] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:51.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:153:0) after 1m0s
[16:01:51.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:153:0)
[16:01:51.591] Timer tick, asking Buildbucket for the build status
[16:01:51.706] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:51.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:154:0) after 1m0s
[16:02:51.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:154:0)
[16:02:51.810] Timer tick, asking Buildbucket for the build status
[16:02:52.058] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:52.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:155:0) after 1m0s
[16:03:52.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:155:0)
[16:03:52.137] Timer tick, asking Buildbucket for the build status
[16:03:52.304] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:52.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:156:0) after 1m0s
[16:04:52.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:156:0)
[16:04:52.353] Timer tick, asking Buildbucket for the build status
[16:04:57.621] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:57.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:157:0) after 1m0s
[16:05:58.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:157:0)
[16:05:58.052] Timer tick, asking Buildbucket for the build status
[16:05:58.638] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:58.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:158:0) after 1m0s
[16:06:58.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:158:0)
[16:06:58.708] Timer tick, asking Buildbucket for the build status
[16:06:58.918] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:58.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:159:0) after 1m0s
[16:07:58.978] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:159:0)
[16:07:58.978] Timer tick, asking Buildbucket for the build status
[16:07:59.083] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:59.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:160:0) after 1m0s
[16:08:59.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:160:0)
[16:08:59.216] Timer tick, asking Buildbucket for the build status
[16:08:59.594] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:59.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:161:0) after 1m0s
[16:09:59.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:161:0)
[16:09:59.715] Timer tick, asking Buildbucket for the build status
[16:10:03.564] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:03.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:162:0) after 1m0s
[16:11:03.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:162:0)
[16:11:03.636] Timer tick, asking Buildbucket for the build status
[16:11:03.838] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:03.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:163:0) after 1m0s
[16:12:04.100] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:163:0)
[16:12:04.100] Timer tick, asking Buildbucket for the build status
[16:12:04.308] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:04.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:164:0) after 1m0s
[16:13:04.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:164:0)
[16:13:04.341] Timer tick, asking Buildbucket for the build status
[16:13:04.515] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:04.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:165:0) after 1m0s
[16:14:04.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:165:0)
[16:14:04.691] Timer tick, asking Buildbucket for the build status
[16:14:04.846] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:04.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:166:0) after 1m0s
[16:15:04.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:166:0)
[16:15:04.967] Timer tick, asking Buildbucket for the build status
[16:15:05.193] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:05.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:167:0) after 1m0s
[16:16:05.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:167:0)
[16:16:05.212] Timer tick, asking Buildbucket for the build status
[16:16:05.427] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:05.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:168:0) after 1m0s
[16:17:05.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:168:0)
[16:17:05.480] Timer tick, asking Buildbucket for the build status
[16:17:05.966] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:05.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:169:0) after 1m0s
[16:18:06.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:169:0)
[16:18:06.023] Timer tick, asking Buildbucket for the build status
[16:18:06.344] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:06.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:170:0) after 1m0s
[16:19:06.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:170:0)
[16:19:06.392] Timer tick, asking Buildbucket for the build status
[16:19:06.516] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:06.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:171:0) after 1m0s
[16:20:06.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:171:0)
[16:20:06.624] Timer tick, asking Buildbucket for the build status
[16:20:06.767] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:06.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:172:0) after 1m0s
[16:21:06.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:172:0)
[16:21:06.803] Timer tick, asking Buildbucket for the build status
[16:21:06.965] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:06.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:173:0) after 1m0s
[16:22:07.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:173:0)
[16:22:07.018] Timer tick, asking Buildbucket for the build status
[16:22:07.329] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:07.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:174:0) after 1m0s
[16:23:07.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:174:0)
[16:23:07.405] Timer tick, asking Buildbucket for the build status
[16:23:07.541] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:07.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:175:0) after 1m0s
[16:24:07.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:175:0)
[16:24:07.592] Timer tick, asking Buildbucket for the build status
[16:24:07.693] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:07.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:176:0) after 1m0s
[16:25:07.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:176:0)
[16:25:07.738] Timer tick, asking Buildbucket for the build status
[16:25:07.917] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:07.917] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:177:0) after 1m0s
[16:26:08.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:177:0)
[16:26:08.111] Timer tick, asking Buildbucket for the build status
[16:26:08.377] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:08.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:178:0) after 1m0s
[16:27:08.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:178:0)
[16:27:08.402] Timer tick, asking Buildbucket for the build status
[16:27:08.565] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:08.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:179:0) after 1m0s
[16:28:08.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:179:0)
[16:28:08.685] Timer tick, asking Buildbucket for the build status
[16:28:09.036] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:09.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:180:0) after 1m0s
[16:29:09.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:180:0)
[16:29:09.063] Timer tick, asking Buildbucket for the build status
[16:29:09.218] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:09.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:181:0) after 1m0s
[16:30:09.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:181:0)
[16:30:09.287] Timer tick, asking Buildbucket for the build status
[16:30:10.342] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:10.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:182:0) after 1m0s
[16:31:10.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:182:0)
[16:31:10.433] Timer tick, asking Buildbucket for the build status
[16:31:10.574] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:10.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:183:0) after 1m0s
[16:32:10.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:183:0)
[16:32:10.600] Timer tick, asking Buildbucket for the build status
[16:32:10.869] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:10.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:184:0) after 1m0s
[16:33:11.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:184:0)
[16:33:11.119] Timer tick, asking Buildbucket for the build status
[16:33:11.289] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:11.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:185:0) after 1m0s
[16:34:11.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:185:0)
[16:34:11.463] Timer tick, asking Buildbucket for the build status
[16:34:11.786] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:11.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:186:0) after 1m0s
[16:35:11.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:186:0)
[16:35:11.849] Timer tick, asking Buildbucket for the build status
[16:35:12.285] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:12.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:187:0) after 1m0s
[16:36:12.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:187:0)
[16:36:12.373] Timer tick, asking Buildbucket for the build status
[16:36:12.562] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:12.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:188:0) after 1m0s
[16:37:12.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:188:0)
[16:37:12.704] Timer tick, asking Buildbucket for the build status
[16:37:12.869] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:12.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:189:0) after 1m0s
[16:38:12.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:189:0)
[16:38:12.912] Timer tick, asking Buildbucket for the build status
[16:38:13.107] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:13.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:190:0) after 1m0s
[16:39:13.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:190:0)
[16:39:13.145] Timer tick, asking Buildbucket for the build status
[16:39:13.322] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:13.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:191:0) after 1m0s
[16:40:13.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:191:0)
[16:40:13.353] Timer tick, asking Buildbucket for the build status
[16:40:13.512] Build 8882857710220903920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:13.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048287772420764320:192:0) after 1m0s
[16:40:27.408] Received PubSub notification, asking Buildbucket for the build status
[16:40:27.500] Build 8882857710220903920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:40:27.500] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "completed_ts": "1587055226668786",
    "created_by": "project:infra",
    "created_ts": "1587043767679357",
    "id": "8882857710220903920",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4115.5\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"eed620d7-d772-4e8b-b519-52577a200693\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4115.5\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "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\": \"84.0.4115.5\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"eed620d7-d772-4e8b-b519-52577a200693\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-ytni\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"84.0.4115.5\"}, \"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-ytni\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"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\": [\"4985-2a273fe\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1587045058665495",
    "status": "COMPLETED",
    "status_changed_ts": "1587055227034601",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9048287772420764320",
      "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/8882857710220903920/+/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:4b9bffa6960ac610",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1587055227053674",
    "url": "https://ci.chromium.org/b/8882857710220903920",
    "utcnow_ts": "1587055227491434"
  }
}
[16:40:27.500] Invocation finished in 3h11m1.303529442s with status SUCCEEDED