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

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

{
  "version": "86.0.4240.112"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[12:18:22.837] New invocation is queued and will start shortly
[12:18:22.837] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[12:18:25.815] Starting the invocation (attempt 1)
[12:18:25.882] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:18:25.882] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:18:25.882] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9031078819281015136",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4240.112\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"042e847f-160d-49c7-87f2-275d8f239ab1\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4240.112\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9031078819281015136",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[12:18:26.815] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1603455506027522",
    "id": "8865648755270326400",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4240.112\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"042e847f-160d-49c7-87f2-275d8f239ab1\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4240.112\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1603455506506374",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9031078819281015136",
      "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/8865648755270326400/+/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": "1603455506506728",
    "url": "https://ci.chromium.org/b/8865648755270326400",
    "utcnow_ts": "1603455506767102"
  }
}
[12:18:26.815] Task URL: https://ci.chromium.org/b/8865648755270326400
[12:18:26.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:2:0) after 1m0s
[12:19:08.873] Received PubSub notification, asking Buildbucket for the build status
[12:19:08.968] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:26.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:2:0)
[12:19:26.852] Timer tick, asking Buildbucket for the build status
[12:19:26.934] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:26.934] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:4:0) after 1m0s
[12:20:26.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:4:0)
[12:20:26.954] Timer tick, asking Buildbucket for the build status
[12:20:27.092] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:27.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:5:0) after 1m0s
[12:21:27.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:5:0)
[12:21:27.149] Timer tick, asking Buildbucket for the build status
[12:21:27.309] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:27.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:6:0) after 1m0s
[12:22:27.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:6:0)
[12:22:27.369] Timer tick, asking Buildbucket for the build status
[12:22:27.571] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:27.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:7:0) after 1m0s
[12:23:27.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:7:0)
[12:23:27.594] Timer tick, asking Buildbucket for the build status
[12:23:27.688] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:27.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:8:0) after 1m0s
[12:24:27.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:8:0)
[12:24:27.775] Timer tick, asking Buildbucket for the build status
[12:24:27.904] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:27.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:9:0) after 1m0s
[12:25:27.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:9:0)
[12:25:27.935] Timer tick, asking Buildbucket for the build status
[12:25:27.994] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:27.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:10:0) after 1m0s
[12:26:28.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:10:0)
[12:26:28.098] Timer tick, asking Buildbucket for the build status
[12:26:28.162] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:28.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:11:0) after 1m0s
[12:27:28.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:11:0)
[12:27:28.161] Timer tick, asking Buildbucket for the build status
[12:27:28.217] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:28.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:12:0) after 1m0s
[12:28:28.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:12:0)
[12:28:28.287] Timer tick, asking Buildbucket for the build status
[12:28:28.392] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:28.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:13:0) after 1m0s
[12:29:28.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:13:0)
[12:29:28.405] Timer tick, asking Buildbucket for the build status
[12:29:28.518] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:28.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:14:0) after 1m0s
[12:30:28.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:14:0)
[12:30:28.629] Timer tick, asking Buildbucket for the build status
[12:30:28.725] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:28.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:15:0) after 1m0s
[12:31:28.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:15:0)
[12:31:28.755] Timer tick, asking Buildbucket for the build status
[12:31:28.902] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:28.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:16:0) after 1m0s
[12:32:28.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:16:0)
[12:32:28.925] Timer tick, asking Buildbucket for the build status
[12:32:28.989] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:28.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:17:0) after 1m0s
[12:33:29.050] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:17:0)
[12:33:29.050] Timer tick, asking Buildbucket for the build status
[12:33:29.149] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:29.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:18:0) after 1m0s
[12:34:29.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:18:0)
[12:34:29.202] Timer tick, asking Buildbucket for the build status
[12:34:29.293] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:29.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:19:0) after 1m0s
[12:35:29.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:19:0)
[12:35:29.375] Timer tick, asking Buildbucket for the build status
[12:35:29.454] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:29.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:20:0) after 1m0s
[12:36:29.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:20:0)
[12:36:29.499] Timer tick, asking Buildbucket for the build status
[12:36:29.572] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:29.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:21:0) after 1m0s
[12:37:29.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:21:0)
[12:37:29.601] Timer tick, asking Buildbucket for the build status
[12:37:29.669] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:29.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:22:0) after 1m0s
[12:38:29.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:22:0)
[12:38:29.735] Timer tick, asking Buildbucket for the build status
[12:38:29.854] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:29.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:23:0) after 1m0s
[12:39:29.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:23:0)
[12:39:29.868] Timer tick, asking Buildbucket for the build status
[12:39:30.043] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:30.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:24:0) after 1m0s
[12:40:30.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:24:0)
[12:40:30.017] Timer tick, asking Buildbucket for the build status
[12:40:30.138] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:30.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:25:0) after 1m0s
[12:41:30.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:25:0)
[12:41:30.181] Timer tick, asking Buildbucket for the build status
[12:41:30.307] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:30.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:26:0) after 1m0s
[12:42:30.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:26:0)
[12:42:30.389] Timer tick, asking Buildbucket for the build status
[12:42:30.530] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:30.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:27:0) after 1m0s
[12:43:30.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:27:0)
[12:43:30.621] Timer tick, asking Buildbucket for the build status
[12:43:30.905] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:30.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:28:0) after 1m0s
[12:44:30.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:28:0)
[12:44:30.932] Timer tick, asking Buildbucket for the build status
[12:44:31.048] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:31.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:29:0) after 1m0s
[12:45:31.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:29:0)
[12:45:31.043] Timer tick, asking Buildbucket for the build status
[12:45:31.118] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:31.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:30:0) after 1m0s
[12:46:31.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:30:0)
[12:46:31.114] Timer tick, asking Buildbucket for the build status
[12:46:31.173] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:31.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:31:0) after 1m0s
[12:47:31.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:31:0)
[12:47:31.263] Timer tick, asking Buildbucket for the build status
[12:47:31.328] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:31.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:32:0) after 1m0s
[12:48:31.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:32:0)
[12:48:31.430] Timer tick, asking Buildbucket for the build status
[12:48:31.526] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:31.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:33:0) after 1m0s
[12:49:31.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:33:0)
[12:49:31.697] Timer tick, asking Buildbucket for the build status
[12:49:31.985] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:31.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:34:0) after 1m0s
[12:50:33.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:34:0)
[12:50:33.494] Timer tick, asking Buildbucket for the build status
[12:50:33.548] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:33.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:35:0) after 1m0s
[12:51:33.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:35:0)
[12:51:33.572] Timer tick, asking Buildbucket for the build status
[12:51:33.629] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:33.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:36:0) after 1m0s
[12:52:33.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:36:0)
[12:52:33.737] Timer tick, asking Buildbucket for the build status
[12:52:33.824] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:33.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:37:0) after 1m0s
[12:53:33.888] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:37:0)
[12:53:33.888] Timer tick, asking Buildbucket for the build status
[12:53:34.184] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:34.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:38:0) after 1m0s
[12:54:34.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:38:0)
[12:54:34.281] Timer tick, asking Buildbucket for the build status
[12:54:34.361] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:34.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:39:0) after 1m0s
[12:55:34.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:39:0)
[12:55:34.409] Timer tick, asking Buildbucket for the build status
[12:55:34.509] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:34.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:40:0) after 1m0s
[12:56:34.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:40:0)
[12:56:34.580] Timer tick, asking Buildbucket for the build status
[12:56:34.897] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:34.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:41:0) after 1m0s
[12:57:34.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:41:0)
[12:57:34.947] Timer tick, asking Buildbucket for the build status
[12:57:35.006] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:35.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:42:0) after 1m0s
[12:58:35.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:42:0)
[12:58:35.077] Timer tick, asking Buildbucket for the build status
[12:58:35.403] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:35.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:43:0) after 1m0s
[12:59:35.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:43:0)
[12:59:35.429] Timer tick, asking Buildbucket for the build status
[12:59:35.725] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:35.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:44:0) after 1m0s
[13:00:35.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:44:0)
[13:00:35.841] Timer tick, asking Buildbucket for the build status
[13:00:36.025] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:36.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:45:0) after 1m0s
[13:01:36.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:45:0)
[13:01:36.023] Timer tick, asking Buildbucket for the build status
[13:01:36.098] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:36.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:46:0) after 1m0s
[13:02:36.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:46:0)
[13:02:36.133] Timer tick, asking Buildbucket for the build status
[13:02:36.201] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:36.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:47:0) after 1m0s
[13:03:36.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:47:0)
[13:03:36.287] Timer tick, asking Buildbucket for the build status
[13:03:36.587] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:36.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:48:0) after 1m0s
[13:04:36.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:48:0)
[13:04:36.664] Timer tick, asking Buildbucket for the build status
[13:04:36.728] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:36.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:49:0) after 1m0s
[13:05:36.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:49:0)
[13:05:36.827] Timer tick, asking Buildbucket for the build status
[13:05:36.940] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:36.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:50:0) after 1m0s
[13:06:36.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:50:0)
[13:06:36.994] Timer tick, asking Buildbucket for the build status
[13:06:37.052] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:37.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:51:0) after 1m0s
[13:07:37.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:51:0)
[13:07:37.132] Timer tick, asking Buildbucket for the build status
[13:07:37.324] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:37.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:52:0) after 1m0s
[13:08:37.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:52:0)
[13:08:37.326] Timer tick, asking Buildbucket for the build status
[13:08:37.435] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:37.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:53:0) after 1m0s
[13:09:37.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:53:0)
[13:09:37.489] Timer tick, asking Buildbucket for the build status
[13:09:37.559] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:37.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:54:0) after 1m0s
[13:10:37.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:54:0)
[13:10:37.594] Timer tick, asking Buildbucket for the build status
[13:10:37.656] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:37.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:55:0) after 1m0s
[13:11:37.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:55:0)
[13:11:37.701] Timer tick, asking Buildbucket for the build status
[13:11:37.758] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:37.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:56:0) after 1m0s
[13:12:37.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:56:0)
[13:12:37.810] Timer tick, asking Buildbucket for the build status
[13:12:37.873] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:37.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:57:0) after 1m0s
[13:13:37.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:57:0)
[13:13:37.896] Timer tick, asking Buildbucket for the build status
[13:13:38.198] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:38.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:58:0) after 1m0s
[13:14:38.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:58:0)
[13:14:38.227] Timer tick, asking Buildbucket for the build status
[13:14:38.306] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:38.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:59:0) after 1m0s
[13:15:38.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:59:0)
[13:15:38.321] Timer tick, asking Buildbucket for the build status
[13:15:38.396] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:38.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:60:0) after 1m0s
[13:16:38.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:60:0)
[13:16:38.434] Timer tick, asking Buildbucket for the build status
[13:16:38.492] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:38.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:61:0) after 1m0s
[13:17:38.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:61:0)
[13:17:38.605] Timer tick, asking Buildbucket for the build status
[13:17:38.662] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:38.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:62:0) after 1m0s
[13:18:38.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:62:0)
[13:18:38.787] Timer tick, asking Buildbucket for the build status
[13:18:38.908] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:38.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:63:0) after 1m0s
[13:19:38.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:63:0)
[13:19:38.968] Timer tick, asking Buildbucket for the build status
[13:19:39.054] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:39.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:64:0) after 1m0s
[13:20:39.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:64:0)
[13:20:39.128] Timer tick, asking Buildbucket for the build status
[13:20:39.192] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:39.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:65:0) after 1m0s
[13:21:39.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:65:0)
[13:21:39.226] Timer tick, asking Buildbucket for the build status
[13:21:39.424] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:39.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:66:0) after 1m0s
[13:22:39.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:66:0)
[13:22:39.490] Timer tick, asking Buildbucket for the build status
[13:22:39.632] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:39.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:67:0) after 1m0s
[13:23:39.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:67:0)
[13:23:39.710] Timer tick, asking Buildbucket for the build status
[13:23:39.859] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:39.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:68:0) after 1m0s
[13:24:39.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:68:0)
[13:24:39.908] Timer tick, asking Buildbucket for the build status
[13:24:39.971] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:39.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:69:0) after 1m0s
[13:25:40.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:69:0)
[13:25:40.099] Timer tick, asking Buildbucket for the build status
[13:25:40.175] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:40.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:70:0) after 1m0s
[13:26:40.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:70:0)
[13:26:40.213] Timer tick, asking Buildbucket for the build status
[13:26:40.293] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:40.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:71:0) after 1m0s
[13:27:40.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:71:0)
[13:27:40.321] Timer tick, asking Buildbucket for the build status
[13:27:40.370] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:40.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:72:0) after 1m0s
[13:28:40.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:72:0)
[13:28:40.377] Timer tick, asking Buildbucket for the build status
[13:28:40.604] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:40.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:73:0) after 1m0s
[13:29:40.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:73:0)
[13:29:40.622] Timer tick, asking Buildbucket for the build status
[13:29:40.702] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:40.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:74:0) after 1m0s
[13:30:40.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:74:0)
[13:30:40.786] Timer tick, asking Buildbucket for the build status
[13:30:40.876] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:40.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:75:0) after 1m0s
[13:31:41.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:75:0)
[13:31:41.003] Timer tick, asking Buildbucket for the build status
[13:31:41.202] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:41.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:76:0) after 1m0s
[13:32:41.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:76:0)
[13:32:41.411] Timer tick, asking Buildbucket for the build status
[13:32:41.482] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:41.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:77:0) after 1m0s
[13:33:41.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:77:0)
[13:33:41.508] Timer tick, asking Buildbucket for the build status
[13:33:41.628] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:41.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:78:0) after 1m0s
[13:34:41.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:78:0)
[13:34:41.657] Timer tick, asking Buildbucket for the build status
[13:34:42.088] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:42.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:79:0) after 1m0s
[13:35:42.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:79:0)
[13:35:42.237] Timer tick, asking Buildbucket for the build status
[13:35:42.433] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:42.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:80:0) after 1m0s
[13:36:42.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:80:0)
[13:36:42.546] Timer tick, asking Buildbucket for the build status
[13:36:42.629] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:42.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:81:0) after 1m0s
[13:37:42.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:81:0)
[13:37:42.747] Timer tick, asking Buildbucket for the build status
[13:37:42.813] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:42.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:82:0) after 1m0s
[13:38:42.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:82:0)
[13:38:42.962] Timer tick, asking Buildbucket for the build status
[13:38:43.055] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:43.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:83:0) after 1m0s
[13:39:43.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:83:0)
[13:39:43.060] Timer tick, asking Buildbucket for the build status
[13:39:43.202] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:43.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:84:0) after 1m0s
[13:40:43.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:84:0)
[13:40:43.261] Timer tick, asking Buildbucket for the build status
[13:40:43.589] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:43.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:85:0) after 1m0s
[13:41:43.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:85:0)
[13:41:43.622] Timer tick, asking Buildbucket for the build status
[13:41:43.690] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:43.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:86:0) after 1m0s
[13:42:43.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:86:0)
[13:42:43.761] Timer tick, asking Buildbucket for the build status
[13:42:44.186] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:44.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:87:0) after 1m0s
[13:43:44.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:87:0)
[13:43:44.196] Timer tick, asking Buildbucket for the build status
[13:43:44.349] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:44.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:88:0) after 1m0s
[13:44:44.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:88:0)
[13:44:44.404] Timer tick, asking Buildbucket for the build status
[13:44:44.463] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:44.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:89:0) after 1m0s
[13:45:44.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:89:0)
[13:45:44.512] Timer tick, asking Buildbucket for the build status
[13:45:44.667] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:44.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:90:0) after 1m0s
[13:46:44.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:90:0)
[13:46:44.656] Timer tick, asking Buildbucket for the build status
[13:46:44.729] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:44.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:91:0) after 1m0s
[13:47:44.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:91:0)
[13:47:44.804] Timer tick, asking Buildbucket for the build status
[13:47:44.868] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:44.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:92:0) after 1m0s
[13:48:44.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:92:0)
[13:48:44.880] Timer tick, asking Buildbucket for the build status
[13:48:45.007] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:45.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:93:0) after 1m0s
[13:49:45.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:93:0)
[13:49:45.033] Timer tick, asking Buildbucket for the build status
[13:49:45.133] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:45.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:94:0) after 1m0s
[13:50:45.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:94:0)
[13:50:45.206] Timer tick, asking Buildbucket for the build status
[13:50:45.353] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:45.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:95:0) after 1m0s
[13:51:45.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:95:0)
[13:51:45.566] Timer tick, asking Buildbucket for the build status
[13:51:45.625] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:45.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:96:0) after 1m0s
[13:52:45.706] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:96:0)
[13:52:45.706] Timer tick, asking Buildbucket for the build status
[13:52:45.906] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:45.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:97:0) after 1m0s
[13:53:46.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:97:0)
[13:53:46.137] Timer tick, asking Buildbucket for the build status
[13:53:46.278] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:46.278] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:98:0) after 1m0s
[13:54:46.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:98:0)
[13:54:46.368] Timer tick, asking Buildbucket for the build status
[13:54:46.442] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:46.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:99:0) after 1m0s
[13:55:46.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:99:0)
[13:55:46.515] Timer tick, asking Buildbucket for the build status
[13:55:46.579] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:46.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:100:0) after 1m0s
[13:56:46.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:100:0)
[13:56:46.798] Timer tick, asking Buildbucket for the build status
[13:56:46.864] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:46.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:101:0) after 1m0s
[13:57:46.990] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:101:0)
[13:57:46.990] Timer tick, asking Buildbucket for the build status
[13:57:47.181] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:47.181] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:102:0) after 1m0s
[13:58:47.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:102:0)
[13:58:47.673] Timer tick, asking Buildbucket for the build status
[13:58:47.789] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:47.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:103:0) after 1m0s
[13:59:47.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:103:0)
[13:59:47.909] Timer tick, asking Buildbucket for the build status
[13:59:47.992] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:47.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:104:0) after 1m0s
[14:00:48.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:104:0)
[14:00:48.218] Timer tick, asking Buildbucket for the build status
[14:00:48.279] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:48.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:105:0) after 1m0s
[14:01:48.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:105:0)
[14:01:48.593] Timer tick, asking Buildbucket for the build status
[14:01:48.668] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:48.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:106:0) after 1m0s
[14:02:48.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:106:0)
[14:02:48.813] Timer tick, asking Buildbucket for the build status
[14:02:48.986] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:48.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:107:0) after 1m0s
[14:03:49.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:107:0)
[14:03:49.126] Timer tick, asking Buildbucket for the build status
[14:03:49.573] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:49.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:108:0) after 1m0s
[14:04:49.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:108:0)
[14:04:49.633] Timer tick, asking Buildbucket for the build status
[14:04:49.705] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:49.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:109:0) after 1m0s
[14:05:49.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:109:0)
[14:05:49.763] Timer tick, asking Buildbucket for the build status
[14:05:49.950] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:49.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:110:0) after 1m0s
[14:06:50.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:110:0)
[14:06:50.025] Timer tick, asking Buildbucket for the build status
[14:06:50.132] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:50.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:111:0) after 1m0s
[14:07:50.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:111:0)
[14:07:50.208] Timer tick, asking Buildbucket for the build status
[14:07:50.280] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:50.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:112:0) after 1m0s
[14:08:52.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:112:0)
[14:08:52.372] Timer tick, asking Buildbucket for the build status
[14:08:53.336] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:53.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:113:0) after 1m0s
[14:09:53.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:113:0)
[14:09:53.671] Timer tick, asking Buildbucket for the build status
[14:09:53.747] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:53.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:114:0) after 1m0s
[14:10:53.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:114:0)
[14:10:53.985] Timer tick, asking Buildbucket for the build status
[14:10:54.234] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:54.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:115:0) after 1m0s
[14:11:54.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:115:0)
[14:11:54.254] Timer tick, asking Buildbucket for the build status
[14:11:54.369] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:54.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:116:0) after 1m0s
[14:12:54.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:116:0)
[14:12:54.427] Timer tick, asking Buildbucket for the build status
[14:12:54.700] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:54.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:117:0) after 1m0s
[14:13:54.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:117:0)
[14:13:54.815] Timer tick, asking Buildbucket for the build status
[14:13:54.962] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:54.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:118:0) after 1m0s
[14:14:56.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:118:0)
[14:14:56.277] Timer tick, asking Buildbucket for the build status
[14:14:56.350] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:56.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:119:0) after 1m0s
[14:15:56.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:119:0)
[14:15:56.455] Timer tick, asking Buildbucket for the build status
[14:15:56.539] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:56.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:120:0) after 1m0s
[14:16:56.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:120:0)
[14:16:56.710] Timer tick, asking Buildbucket for the build status
[14:16:56.880] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:56.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:121:0) after 1m0s
[14:17:56.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:121:0)
[14:17:56.951] Timer tick, asking Buildbucket for the build status
[14:17:57.072] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:57.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:122:0) after 1m0s
[14:18:57.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:122:0)
[14:18:57.205] Timer tick, asking Buildbucket for the build status
[14:18:57.312] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:57.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:123:0) after 1m0s
[14:19:57.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:123:0)
[14:19:57.413] Timer tick, asking Buildbucket for the build status
[14:19:57.478] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:57.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:124:0) after 1m0s
[14:20:57.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:124:0)
[14:20:57.494] Timer tick, asking Buildbucket for the build status
[14:20:57.701] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:57.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:125:0) after 1m0s
[14:21:57.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:125:0)
[14:21:57.766] Timer tick, asking Buildbucket for the build status
[14:21:57.921] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:57.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:126:0) after 1m0s
[14:22:58.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:126:0)
[14:22:58.174] Timer tick, asking Buildbucket for the build status
[14:22:58.254] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:58.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:127:0) after 1m0s
[14:23:58.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:127:0)
[14:23:58.334] Timer tick, asking Buildbucket for the build status
[14:23:58.706] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:58.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:128:0) after 1m0s
[14:24:58.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:128:0)
[14:24:58.744] Timer tick, asking Buildbucket for the build status
[14:24:58.822] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:58.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:129:0) after 1m0s
[14:25:58.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:129:0)
[14:25:58.894] Timer tick, asking Buildbucket for the build status
[14:25:58.968] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:58.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:130:0) after 1m0s
[14:26:59.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:130:0)
[14:26:59.188] Timer tick, asking Buildbucket for the build status
[14:26:59.263] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:59.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:131:0) after 1m0s
[14:27:59.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:131:0)
[14:27:59.356] Timer tick, asking Buildbucket for the build status
[14:27:59.547] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:59.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:132:0) after 1m0s
[14:28:59.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:132:0)
[14:28:59.533] Timer tick, asking Buildbucket for the build status
[14:28:59.696] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:59.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:133:0) after 1m0s
[14:29:59.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:133:0)
[14:29:59.770] Timer tick, asking Buildbucket for the build status
[14:29:59.896] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:59.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:134:0) after 1m0s
[14:30:59.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:134:0)
[14:30:59.936] Timer tick, asking Buildbucket for the build status
[14:31:00.246] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:00.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:135:0) after 1m0s
[14:32:00.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:135:0)
[14:32:00.287] Timer tick, asking Buildbucket for the build status
[14:32:00.350] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:00.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:136:0) after 1m0s
[14:33:00.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:136:0)
[14:33:00.624] Timer tick, asking Buildbucket for the build status
[14:33:00.736] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:00.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:137:0) after 1m0s
[14:34:02.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:137:0)
[14:34:02.118] Timer tick, asking Buildbucket for the build status
[14:34:02.223] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:02.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:138:0) after 1m0s
[14:35:02.855] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:138:0)
[14:35:02.855] Timer tick, asking Buildbucket for the build status
[14:35:02.919] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:02.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:139:0) after 1m0s
[14:36:03.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:139:0)
[14:36:03.741] Timer tick, asking Buildbucket for the build status
[14:36:05.010] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:05.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:140:0) after 1m0s
[14:37:05.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:140:0)
[14:37:05.204] Timer tick, asking Buildbucket for the build status
[14:37:05.288] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:05.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:141:0) after 1m0s
[14:38:05.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:141:0)
[14:38:05.361] Timer tick, asking Buildbucket for the build status
[14:38:05.704] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:05.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:142:0) after 1m0s
[14:39:05.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:142:0)
[14:39:05.806] Timer tick, asking Buildbucket for the build status
[14:39:06.119] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:06.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:143:0) after 1m0s
[14:40:06.220] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:143:0)
[14:40:06.220] Timer tick, asking Buildbucket for the build status
[14:40:06.346] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:06.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:144:0) after 1m0s
[14:41:06.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:144:0)
[14:41:06.339] Timer tick, asking Buildbucket for the build status
[14:41:06.960] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:06.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:145:0) after 1m0s
[14:42:07.120] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:145:0)
[14:42:07.120] Timer tick, asking Buildbucket for the build status
[14:42:07.231] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:07.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:146:0) after 1m0s
[14:43:07.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:146:0)
[14:43:07.308] Timer tick, asking Buildbucket for the build status
[14:43:07.379] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:07.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:147:0) after 1m0s
[14:44:07.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:147:0)
[14:44:07.512] Timer tick, asking Buildbucket for the build status
[14:44:07.645] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:07.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:148:0) after 1m0s
[14:45:07.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:148:0)
[14:45:07.703] Timer tick, asking Buildbucket for the build status
[14:45:07.912] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:07.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:149:0) after 1m0s
[14:46:07.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:149:0)
[14:46:07.922] Timer tick, asking Buildbucket for the build status
[14:46:08.246] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:08.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:150:0) after 1m0s
[14:47:08.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:150:0)
[14:47:08.405] Timer tick, asking Buildbucket for the build status
[14:47:08.482] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:08.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:151:0) after 1m0s
[14:48:08.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:151:0)
[14:48:08.502] Timer tick, asking Buildbucket for the build status
[14:48:08.589] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:08.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:152:0) after 1m0s
[14:49:08.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:152:0)
[14:49:08.670] Timer tick, asking Buildbucket for the build status
[14:49:08.795] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:08.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:153:0) after 1m0s
[14:50:08.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:153:0)
[14:50:08.879] Timer tick, asking Buildbucket for the build status
[14:50:08.957] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:08.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:154:0) after 1m0s
[14:51:09.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:154:0)
[14:51:09.023] Timer tick, asking Buildbucket for the build status
[14:51:09.094] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:09.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:155:0) after 1m0s
[14:52:09.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:155:0)
[14:52:09.103] Timer tick, asking Buildbucket for the build status
[14:52:09.265] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:09.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:156:0) after 1m0s
[14:53:09.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:156:0)
[14:53:09.295] Timer tick, asking Buildbucket for the build status
[14:53:09.362] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:09.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:157:0) after 1m0s
[14:54:09.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:157:0)
[14:54:09.452] Timer tick, asking Buildbucket for the build status
[14:54:09.678] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:09.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:158:0) after 1m0s
[14:55:09.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:158:0)
[14:55:09.734] Timer tick, asking Buildbucket for the build status
[14:55:09.804] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:09.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:159:0) after 1m0s
[14:56:09.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:159:0)
[14:56:09.849] Timer tick, asking Buildbucket for the build status
[14:56:09.919] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:09.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:160:0) after 1m0s
[14:57:09.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:160:0)
[14:57:09.963] Timer tick, asking Buildbucket for the build status
[14:57:10.031] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:10.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:161:0) after 1m0s
[14:58:10.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:161:0)
[14:58:10.117] Timer tick, asking Buildbucket for the build status
[14:58:10.183] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:10.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:162:0) after 1m0s
[14:59:10.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:162:0)
[14:59:10.223] Timer tick, asking Buildbucket for the build status
[14:59:11.294] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:11.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:163:0) after 1m0s
[15:00:11.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:163:0)
[15:00:11.541] Timer tick, asking Buildbucket for the build status
[15:00:11.630] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:11.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:164:0) after 1m0s
[15:01:12.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:164:0)
[15:01:12.018] Timer tick, asking Buildbucket for the build status
[15:01:12.197] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:12.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:165:0) after 1m0s
[15:02:12.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:165:0)
[15:02:12.227] Timer tick, asking Buildbucket for the build status
[15:02:12.312] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:12.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:166:0) after 1m0s
[15:03:12.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:166:0)
[15:03:12.314] Timer tick, asking Buildbucket for the build status
[15:03:12.424] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:12.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:167:0) after 1m0s
[15:04:12.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:167:0)
[15:04:12.514] Timer tick, asking Buildbucket for the build status
[15:04:12.639] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:12.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:168:0) after 1m0s
[15:05:12.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:168:0)
[15:05:12.715] Timer tick, asking Buildbucket for the build status
[15:05:14.125] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:14.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:169:0) after 1m0s
[15:06:14.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:169:0)
[15:06:14.185] Timer tick, asking Buildbucket for the build status
[15:06:14.258] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:14.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:170:0) after 1m0s
[15:07:14.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:170:0)
[15:07:14.256] Timer tick, asking Buildbucket for the build status
[15:07:14.320] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:14.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:171:0) after 1m0s
[15:08:14.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:171:0)
[15:08:14.382] Timer tick, asking Buildbucket for the build status
[15:08:14.691] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:14.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:172:0) after 1m0s
[15:09:14.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:172:0)
[15:09:14.742] Timer tick, asking Buildbucket for the build status
[15:09:14.895] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:14.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:173:0) after 1m0s
[15:10:14.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:173:0)
[15:10:14.950] Timer tick, asking Buildbucket for the build status
[15:10:15.608] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:15.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:174:0) after 1m0s
[15:11:15.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:174:0)
[15:11:15.714] Timer tick, asking Buildbucket for the build status
[15:11:15.796] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:15.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:175:0) after 1m0s
[15:12:15.792] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:175:0)
[15:12:15.792] Timer tick, asking Buildbucket for the build status
[15:12:15.866] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:15.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:176:0) after 1m0s
[15:13:15.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:176:0)
[15:13:15.899] Timer tick, asking Buildbucket for the build status
[15:13:16.003] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:16.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:177:0) after 1m0s
[15:14:16.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:177:0)
[15:14:16.195] Timer tick, asking Buildbucket for the build status
[15:14:16.390] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:16.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:178:0) after 1m0s
[15:15:16.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:178:0)
[15:15:16.418] Timer tick, asking Buildbucket for the build status
[15:15:16.562] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:16.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:179:0) after 1m0s
[15:16:16.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:179:0)
[15:16:16.638] Timer tick, asking Buildbucket for the build status
[15:16:17.172] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:17.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:180:0) after 1m0s
[15:17:17.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:180:0)
[15:17:17.186] Timer tick, asking Buildbucket for the build status
[15:17:17.273] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:17.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:181:0) after 1m0s
[15:18:17.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:181:0)
[15:18:17.329] Timer tick, asking Buildbucket for the build status
[15:18:17.670] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:17.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:182:0) after 1m0s
[15:19:17.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:182:0)
[15:19:17.729] Timer tick, asking Buildbucket for the build status
[15:19:17.859] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:17.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:183:0) after 1m0s
[15:20:17.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:183:0)
[15:20:17.885] Timer tick, asking Buildbucket for the build status
[15:20:17.958] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:17.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:184:0) after 1m0s
[15:21:17.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:184:0)
[15:21:17.984] Timer tick, asking Buildbucket for the build status
[15:21:18.142] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:18.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:185:0) after 1m0s
[15:22:18.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:185:0)
[15:22:18.163] Timer tick, asking Buildbucket for the build status
[15:22:18.459] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:18.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:186:0) after 1m0s
[15:23:18.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:186:0)
[15:23:18.549] Timer tick, asking Buildbucket for the build status
[15:23:18.637] Build 8865648755270326400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:18.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031078819281015136:187:0) after 1m0s
[15:23:57.640] Received PubSub notification, asking Buildbucket for the build status
[15:23:57.724] Build 8865648755270326400: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:23:57.725] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1603466637000401",
    "created_by": "project:infra",
    "created_ts": "1603455506027522",
    "id": "8865648755270326400",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4240.112\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"042e847f-160d-49c7-87f2-275d8f239ab1\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4240.112\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-d209\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1603455546348652",
    "status": "COMPLETED",
    "status_changed_ts": "1603466637374215",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9031078819281015136",
      "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/8865648755270326400/+/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:4f6e36e2c73edb10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1603466637388988",
    "url": "https://ci.chromium.org/b/8865648755270326400",
    "utcnow_ts": "1603466637704768"
  }
}
[15:23:57.725] Invocation finished in 3h5m34.905326274s with status SUCCEEDED