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.4234.0"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[07:53:06.542] New invocation is queued and will start shortly
[07:53:06.542] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[07:53:07.917] Starting the invocation (attempt 1)
[07:53:07.960] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:53:07.960] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:53:07.960] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9037346699404837536",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4234.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"f49a6817-8f28-458b-98b1-881980594ad2\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4234.0\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9037346699404837536",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[07:53:08.956] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1597477988314084",
    "id": "8871916636883856528",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4234.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f49a6817-8f28-458b-98b1-881980594ad2\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4234.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1597477988681127",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9037346699404837536",
      "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/8871916636883856528/+/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": "1597477988681294",
    "url": "https://ci.chromium.org/b/8871916636883856528",
    "utcnow_ts": "1597477988936046"
  }
}
[07:53:08.956] Task URL: https://ci.chromium.org/b/8871916636883856528
[07:53:08.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:2:0) after 1m0s
[07:53:20.587] Received PubSub notification, asking Buildbucket for the build status
[07:53:21.168] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:08.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:2:0)
[07:54:08.947] Timer tick, asking Buildbucket for the build status
[07:54:09.121] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:09.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:4:0) after 1m0s
[07:55:09.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:4:0)
[07:55:09.161] Timer tick, asking Buildbucket for the build status
[07:55:09.311] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:09.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:5:0) after 1m0s
[07:56:09.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:5:0)
[07:56:09.349] Timer tick, asking Buildbucket for the build status
[07:56:09.491] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:09.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:6:0) after 1m0s
[07:57:09.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:6:0)
[07:57:09.557] Timer tick, asking Buildbucket for the build status
[07:57:09.820] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:09.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:7:0) after 1m0s
[07:58:09.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:7:0)
[07:58:09.939] Timer tick, asking Buildbucket for the build status
[07:58:10.033] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:10.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:8:0) after 1m0s
[07:59:10.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:8:0)
[07:59:10.097] Timer tick, asking Buildbucket for the build status
[07:59:19.025] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:19.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:9:0) after 1m0s
[08:00:19.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:9:0)
[08:00:19.134] Timer tick, asking Buildbucket for the build status
[08:00:19.233] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:19.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:10:0) after 1m0s
[08:01:19.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:10:0)
[08:01:19.256] Timer tick, asking Buildbucket for the build status
[08:01:19.309] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:19.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:11:0) after 1m0s
[08:02:19.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:11:0)
[08:02:19.404] Timer tick, asking Buildbucket for the build status
[08:02:19.663] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:19.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:12:0) after 1m0s
[08:03:19.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:12:0)
[08:03:19.767] Timer tick, asking Buildbucket for the build status
[08:03:19.869] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:19.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:13:0) after 1m0s
[08:04:19.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:13:0)
[08:04:19.992] Timer tick, asking Buildbucket for the build status
[08:04:20.485] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:20.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:14:0) after 1m0s
[08:05:20.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:14:0)
[08:05:20.693] Timer tick, asking Buildbucket for the build status
[08:05:20.883] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:20.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:15:0) after 1m0s
[08:06:20.980] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:15:0)
[08:06:20.980] Timer tick, asking Buildbucket for the build status
[08:06:21.055] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:21.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:16:0) after 1m0s
[08:07:21.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:16:0)
[08:07:21.176] Timer tick, asking Buildbucket for the build status
[08:07:21.990] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:21.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:17:0) after 1m0s
[08:08:22.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:17:0)
[08:08:22.104] Timer tick, asking Buildbucket for the build status
[08:08:22.256] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:22.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:18:0) after 1m0s
[08:09:22.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:18:0)
[08:09:22.363] Timer tick, asking Buildbucket for the build status
[08:09:22.435] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:22.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:19:0) after 1m0s
[08:10:22.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:19:0)
[08:10:22.684] Timer tick, asking Buildbucket for the build status
[08:10:22.958] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:22.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:20:0) after 1m0s
[08:11:23.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:20:0)
[08:11:23.449] Timer tick, asking Buildbucket for the build status
[08:11:23.575] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:23.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:21:0) after 1m0s
[08:12:23.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:21:0)
[08:12:23.708] Timer tick, asking Buildbucket for the build status
[08:12:23.808] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:23.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:22:0) after 1m0s
[08:13:24.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:22:0)
[08:13:24.051] Timer tick, asking Buildbucket for the build status
[08:13:24.218] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:24.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:23:0) after 1m0s
[08:14:24.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:23:0)
[08:14:24.312] Timer tick, asking Buildbucket for the build status
[08:14:24.471] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:24.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:24:0) after 1m0s
[08:15:24.524] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:24:0)
[08:15:24.524] Timer tick, asking Buildbucket for the build status
[08:15:24.604] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:24.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:25:0) after 1m0s
[08:16:24.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:25:0)
[08:16:24.770] Timer tick, asking Buildbucket for the build status
[08:16:24.852] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:24.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:26:0) after 1m0s
[08:17:24.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:26:0)
[08:17:24.925] Timer tick, asking Buildbucket for the build status
[08:17:25.015] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:25.015] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:27:0) after 1m0s
[08:18:25.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:27:0)
[08:18:25.041] Timer tick, asking Buildbucket for the build status
[08:18:25.305] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:25.305] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:28:0) after 1m0s
[08:19:25.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:28:0)
[08:19:25.408] Timer tick, asking Buildbucket for the build status
[08:19:25.591] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:25.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:29:0) after 1m0s
[08:20:25.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:29:0)
[08:20:25.716] Timer tick, asking Buildbucket for the build status
[08:20:25.907] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:25.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:30:0) after 1m0s
[08:21:26.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:30:0)
[08:21:26.008] Timer tick, asking Buildbucket for the build status
[08:21:26.342] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:26.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:31:0) after 1m0s
[08:22:26.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:31:0)
[08:22:26.427] Timer tick, asking Buildbucket for the build status
[08:22:26.512] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:26.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:32:0) after 1m0s
[08:23:26.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:32:0)
[08:23:26.616] Timer tick, asking Buildbucket for the build status
[08:23:26.740] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:26.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:33:0) after 1m0s
[08:24:26.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:33:0)
[08:24:26.751] Timer tick, asking Buildbucket for the build status
[08:24:26.839] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:26.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:34:0) after 1m0s
[08:25:26.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:34:0)
[08:25:26.936] Timer tick, asking Buildbucket for the build status
[08:25:27.218] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:27.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:35:0) after 1m0s
[08:26:27.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:35:0)
[08:26:27.264] Timer tick, asking Buildbucket for the build status
[08:26:27.349] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:27.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:36:0) after 1m0s
[08:27:27.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:36:0)
[08:27:27.427] Timer tick, asking Buildbucket for the build status
[08:27:27.506] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:27.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:37:0) after 1m0s
[08:28:27.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:37:0)
[08:28:27.511] Timer tick, asking Buildbucket for the build status
[08:28:27.671] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:27.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:38:0) after 1m0s
[08:29:27.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:38:0)
[08:29:27.695] Timer tick, asking Buildbucket for the build status
[08:29:27.987] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:27.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:39:0) after 1m0s
[08:30:28.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:39:0)
[08:30:28.021] Timer tick, asking Buildbucket for the build status
[08:30:28.206] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:28.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:40:0) after 1m0s
[08:31:28.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:40:0)
[08:31:28.243] Timer tick, asking Buildbucket for the build status
[08:31:28.464] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:28.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:41:0) after 1m0s
[08:32:28.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:41:0)
[08:32:28.549] Timer tick, asking Buildbucket for the build status
[08:32:28.634] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:28.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:42:0) after 1m0s
[08:33:28.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:42:0)
[08:33:28.745] Timer tick, asking Buildbucket for the build status
[08:33:28.892] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:28.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:43:0) after 1m0s
[08:34:28.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:43:0)
[08:34:28.966] Timer tick, asking Buildbucket for the build status
[08:34:29.022] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:29.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:44:0) after 1m0s
[08:35:29.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:44:0)
[08:35:29.301] Timer tick, asking Buildbucket for the build status
[08:35:29.401] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:29.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:45:0) after 1m0s
[08:36:29.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:45:0)
[08:36:29.676] Timer tick, asking Buildbucket for the build status
[08:36:29.779] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:29.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:46:0) after 1m0s
[08:37:29.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:46:0)
[08:37:29.922] Timer tick, asking Buildbucket for the build status
[08:37:30.079] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:30.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:47:0) after 1m0s
[08:38:30.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:47:0)
[08:38:30.139] Timer tick, asking Buildbucket for the build status
[08:38:30.238] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:30.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:48:0) after 1m0s
[08:39:30.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:48:0)
[08:39:30.351] Timer tick, asking Buildbucket for the build status
[08:39:30.435] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:30.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:49:0) after 1m0s
[08:40:30.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:49:0)
[08:40:30.538] Timer tick, asking Buildbucket for the build status
[08:40:30.706] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:30.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:50:0) after 1m0s
[08:41:30.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:50:0)
[08:41:30.766] Timer tick, asking Buildbucket for the build status
[08:41:30.852] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:30.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:51:0) after 1m0s
[08:42:31.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:51:0)
[08:42:31.125] Timer tick, asking Buildbucket for the build status
[08:42:31.319] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:31.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:52:0) after 1m0s
[08:43:31.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:52:0)
[08:43:31.395] Timer tick, asking Buildbucket for the build status
[08:43:31.500] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:31.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:53:0) after 1m0s
[08:44:31.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:53:0)
[08:44:31.505] Timer tick, asking Buildbucket for the build status
[08:44:31.581] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:31.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:54:0) after 1m0s
[08:45:31.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:54:0)
[08:45:31.756] Timer tick, asking Buildbucket for the build status
[08:45:31.907] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:31.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:55:0) after 1m0s
[08:46:32.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:55:0)
[08:46:32.133] Timer tick, asking Buildbucket for the build status
[08:46:32.196] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:32.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:56:0) after 1m0s
[08:47:32.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:56:0)
[08:47:32.352] Timer tick, asking Buildbucket for the build status
[08:47:32.556] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:32.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:57:0) after 1m0s
[08:48:32.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:57:0)
[08:48:32.662] Timer tick, asking Buildbucket for the build status
[08:48:32.931] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:32.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:58:0) after 1m0s
[08:49:32.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:58:0)
[08:49:32.907] Timer tick, asking Buildbucket for the build status
[08:49:32.967] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:32.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:59:0) after 1m0s
[08:50:33.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:59:0)
[08:50:33.078] Timer tick, asking Buildbucket for the build status
[08:50:33.325] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:33.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:60:0) after 1m0s
[08:51:33.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:60:0)
[08:51:33.319] Timer tick, asking Buildbucket for the build status
[08:51:36.332] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:36.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:61:0) after 1m0s
[08:52:36.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:61:0)
[08:52:36.344] Timer tick, asking Buildbucket for the build status
[08:52:36.689] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:36.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:62:0) after 1m0s
[08:53:36.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:62:0)
[08:53:36.771] Timer tick, asking Buildbucket for the build status
[08:53:36.921] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:36.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:63:0) after 1m0s
[08:54:37.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:63:0)
[08:54:37.066] Timer tick, asking Buildbucket for the build status
[08:54:37.744] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:37.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:64:0) after 1m0s
[08:55:37.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:64:0)
[08:55:37.817] Timer tick, asking Buildbucket for the build status
[08:55:37.884] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:37.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:65:0) after 1m0s
[08:56:38.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:65:0)
[08:56:38.055] Timer tick, asking Buildbucket for the build status
[08:56:38.168] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:38.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:66:0) after 1m0s
[08:57:38.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:66:0)
[08:57:38.295] Timer tick, asking Buildbucket for the build status
[08:57:38.366] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:38.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:67:0) after 1m0s
[08:58:38.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:67:0)
[08:58:38.403] Timer tick, asking Buildbucket for the build status
[08:58:38.581] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:38.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:68:0) after 1m0s
[08:59:38.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:68:0)
[08:59:38.697] Timer tick, asking Buildbucket for the build status
[08:59:38.913] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:38.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:69:0) after 1m0s
[09:00:38.952] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:69:0)
[09:00:38.952] Timer tick, asking Buildbucket for the build status
[09:00:39.048] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:39.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:70:0) after 1m0s
[09:01:39.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:70:0)
[09:01:39.070] Timer tick, asking Buildbucket for the build status
[09:01:39.157] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:39.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:71:0) after 1m0s
[09:02:39.220] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:71:0)
[09:02:39.220] Timer tick, asking Buildbucket for the build status
[09:02:39.493] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:39.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:72:0) after 1m0s
[09:03:39.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:72:0)
[09:03:39.554] Timer tick, asking Buildbucket for the build status
[09:03:39.825] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:39.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:73:0) after 1m0s
[09:04:39.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:73:0)
[09:04:39.992] Timer tick, asking Buildbucket for the build status
[09:04:40.581] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:40.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:74:0) after 1m0s
[09:05:40.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:74:0)
[09:05:40.601] Timer tick, asking Buildbucket for the build status
[09:05:40.661] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:40.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:75:0) after 1m0s
[09:06:40.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:75:0)
[09:06:40.758] Timer tick, asking Buildbucket for the build status
[09:06:40.825] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:40.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:76:0) after 1m0s
[09:07:40.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:76:0)
[09:07:40.899] Timer tick, asking Buildbucket for the build status
[09:07:41.023] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:41.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:77:0) after 1m0s
[09:08:41.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:77:0)
[09:08:41.044] Timer tick, asking Buildbucket for the build status
[09:08:41.171] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:41.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:78:0) after 1m0s
[09:09:41.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:78:0)
[09:09:41.313] Timer tick, asking Buildbucket for the build status
[09:09:41.543] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:41.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:79:0) after 1m0s
[09:10:41.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:79:0)
[09:10:41.724] Timer tick, asking Buildbucket for the build status
[09:10:41.808] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:41.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:80:0) after 1m0s
[09:11:41.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:80:0)
[09:11:41.983] Timer tick, asking Buildbucket for the build status
[09:11:42.061] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:42.061] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:81:0) after 1m0s
[09:12:42.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:81:0)
[09:12:42.275] Timer tick, asking Buildbucket for the build status
[09:12:42.342] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:42.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:82:0) after 1m0s
[09:13:42.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:82:0)
[09:13:42.534] Timer tick, asking Buildbucket for the build status
[09:13:42.708] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:42.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:83:0) after 1m0s
[09:14:42.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:83:0)
[09:14:42.726] Timer tick, asking Buildbucket for the build status
[09:14:42.961] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:42.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:84:0) after 1m0s
[09:15:43.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:84:0)
[09:15:43.240] Timer tick, asking Buildbucket for the build status
[09:15:43.319] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:43.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:85:0) after 1m0s
[09:16:43.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:85:0)
[09:16:43.429] Timer tick, asking Buildbucket for the build status
[09:16:43.508] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:43.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:86:0) after 1m0s
[09:17:43.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:86:0)
[09:17:43.604] Timer tick, asking Buildbucket for the build status
[09:17:43.686] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:43.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:87:0) after 1m0s
[09:18:43.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:87:0)
[09:18:43.711] Timer tick, asking Buildbucket for the build status
[09:18:43.961] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:43.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:88:0) after 1m0s
[09:19:45.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:88:0)
[09:19:45.293] Timer tick, asking Buildbucket for the build status
[09:19:45.468] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:45.468] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:89:0) after 1m0s
[09:20:45.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:89:0)
[09:20:45.493] Timer tick, asking Buildbucket for the build status
[09:20:45.580] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:45.580] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:90:0) after 1m0s
[09:21:45.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:90:0)
[09:21:45.642] Timer tick, asking Buildbucket for the build status
[09:21:45.847] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:45.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:91:0) after 1m0s
[09:22:45.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:91:0)
[09:22:45.869] Timer tick, asking Buildbucket for the build status
[09:22:45.954] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:45.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:92:0) after 1m0s
[09:23:46.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:92:0)
[09:23:46.044] Timer tick, asking Buildbucket for the build status
[09:23:46.433] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:46.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:93:0) after 1m0s
[09:24:46.443] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:93:0)
[09:24:46.443] Timer tick, asking Buildbucket for the build status
[09:24:46.634] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:46.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:94:0) after 1m0s
[09:25:47.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:94:0)
[09:25:47.457] Timer tick, asking Buildbucket for the build status
[09:25:47.829] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:47.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:95:0) after 1m0s
[09:26:47.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:95:0)
[09:26:47.893] Timer tick, asking Buildbucket for the build status
[09:26:47.975] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:47.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:96:0) after 1m0s
[09:27:47.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:96:0)
[09:27:47.968] Timer tick, asking Buildbucket for the build status
[09:27:48.055] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:48.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:97:0) after 1m0s
[09:28:48.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:97:0)
[09:28:48.033] Timer tick, asking Buildbucket for the build status
[09:28:48.134] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:48.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:98:0) after 1m0s
[09:29:48.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:98:0)
[09:29:48.494] Timer tick, asking Buildbucket for the build status
[09:29:48.707] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:48.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:99:0) after 1m0s
[09:30:48.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:99:0)
[09:30:48.870] Timer tick, asking Buildbucket for the build status
[09:30:48.956] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:48.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:100:0) after 1m0s
[09:31:49.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:100:0)
[09:31:49.289] Timer tick, asking Buildbucket for the build status
[09:31:49.421] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:49.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:101:0) after 1m0s
[09:32:49.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:101:0)
[09:32:49.568] Timer tick, asking Buildbucket for the build status
[09:32:49.715] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:49.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:102:0) after 1m0s
[09:33:49.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:102:0)
[09:33:49.929] Timer tick, asking Buildbucket for the build status
[09:33:50.295] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:50.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:103:0) after 1m0s
[09:34:50.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:103:0)
[09:34:50.603] Timer tick, asking Buildbucket for the build status
[09:34:50.701] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:50.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:104:0) after 1m0s
[09:35:51.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:104:0)
[09:35:51.025] Timer tick, asking Buildbucket for the build status
[09:35:51.129] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:51.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:105:0) after 1m0s
[09:36:51.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:105:0)
[09:36:51.457] Timer tick, asking Buildbucket for the build status
[09:36:51.545] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:51.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:106:0) after 1m0s
[09:37:52.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:106:0)
[09:37:52.054] Timer tick, asking Buildbucket for the build status
[09:37:52.280] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:52.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:107:0) after 1m0s
[09:38:52.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:107:0)
[09:38:52.490] Timer tick, asking Buildbucket for the build status
[09:38:52.683] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:52.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:108:0) after 1m0s
[09:39:52.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:108:0)
[09:39:52.709] Timer tick, asking Buildbucket for the build status
[09:39:52.912] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:52.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:109:0) after 1m0s
[09:40:53.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:109:0)
[09:40:53.037] Timer tick, asking Buildbucket for the build status
[09:40:53.126] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:53.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:110:0) after 1m0s
[09:41:53.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:110:0)
[09:41:53.226] Timer tick, asking Buildbucket for the build status
[09:41:53.290] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:53.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:111:0) after 1m0s
[09:42:53.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:111:0)
[09:42:53.328] Timer tick, asking Buildbucket for the build status
[09:42:53.521] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:53.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:112:0) after 1m0s
[09:43:53.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:112:0)
[09:43:53.540] Timer tick, asking Buildbucket for the build status
[09:43:53.667] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:53.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:113:0) after 1m0s
[09:44:53.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:113:0)
[09:44:53.756] Timer tick, asking Buildbucket for the build status
[09:44:53.840] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:53.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:114:0) after 1m0s
[09:45:53.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:114:0)
[09:45:53.866] Timer tick, asking Buildbucket for the build status
[09:45:54.859] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:54.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:115:0) after 1m0s
[09:46:54.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:115:0)
[09:46:54.862] Timer tick, asking Buildbucket for the build status
[09:46:55.010] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:55.010] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:116:0) after 1m0s
[09:47:55.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:116:0)
[09:47:55.082] Timer tick, asking Buildbucket for the build status
[09:47:55.146] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:55.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:117:0) after 1m0s
[09:48:55.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:117:0)
[09:48:55.145] Timer tick, asking Buildbucket for the build status
[09:48:55.466] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:55.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:118:0) after 1m0s
[09:49:55.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:118:0)
[09:49:55.494] Timer tick, asking Buildbucket for the build status
[09:49:55.572] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:55.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:119:0) after 1m0s
[09:50:55.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:119:0)
[09:50:55.624] Timer tick, asking Buildbucket for the build status
[09:50:55.902] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:55.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:120:0) after 1m0s
[09:51:55.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:120:0)
[09:51:55.989] Timer tick, asking Buildbucket for the build status
[09:51:56.084] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:56.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:121:0) after 1m0s
[09:52:56.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:121:0)
[09:52:56.133] Timer tick, asking Buildbucket for the build status
[09:52:56.242] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:56.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:122:0) after 1m0s
[09:53:56.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:122:0)
[09:53:56.278] Timer tick, asking Buildbucket for the build status
[09:53:56.492] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:56.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:123:0) after 1m0s
[09:54:56.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:123:0)
[09:54:56.522] Timer tick, asking Buildbucket for the build status
[09:54:56.587] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:56.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:124:0) after 1m0s
[09:55:56.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:124:0)
[09:55:56.679] Timer tick, asking Buildbucket for the build status
[09:55:56.925] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:56.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:125:0) after 1m0s
[09:56:56.944] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:125:0)
[09:56:56.944] Timer tick, asking Buildbucket for the build status
[09:56:57.038] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:57.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:126:0) after 1m0s
[09:57:57.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:126:0)
[09:57:57.059] Timer tick, asking Buildbucket for the build status
[09:57:57.207] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:57.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:127:0) after 1m0s
[09:58:57.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:127:0)
[09:58:57.245] Timer tick, asking Buildbucket for the build status
[09:58:57.362] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:57.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:128:0) after 1m0s
[09:59:57.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:128:0)
[09:59:57.657] Timer tick, asking Buildbucket for the build status
[09:59:58.410] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:58.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:129:0) after 1m0s
[10:00:58.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:129:0)
[10:00:58.552] Timer tick, asking Buildbucket for the build status
[10:00:58.713] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:58.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:130:0) after 1m0s
[10:01:58.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:130:0)
[10:01:58.856] Timer tick, asking Buildbucket for the build status
[10:01:58.936] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:58.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:131:0) after 1m0s
[10:02:59.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:131:0)
[10:02:59.026] Timer tick, asking Buildbucket for the build status
[10:02:59.139] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:59.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:132:0) after 1m0s
[10:03:59.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:132:0)
[10:03:59.231] Timer tick, asking Buildbucket for the build status
[10:03:59.432] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:59.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:133:0) after 1m0s
[10:04:59.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:133:0)
[10:04:59.479] Timer tick, asking Buildbucket for the build status
[10:04:59.547] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:59.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:134:0) after 1m0s
[10:05:59.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:134:0)
[10:05:59.610] Timer tick, asking Buildbucket for the build status
[10:05:59.700] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:59.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:135:0) after 1m0s
[10:06:59.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:135:0)
[10:06:59.868] Timer tick, asking Buildbucket for the build status
[10:07:00.138] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:00.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:136:0) after 1m0s
[10:08:00.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:136:0)
[10:08:00.127] Timer tick, asking Buildbucket for the build status
[10:08:00.195] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:00.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:137:0) after 1m0s
[10:09:00.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:137:0)
[10:09:00.473] Timer tick, asking Buildbucket for the build status
[10:09:00.582] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:00.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:138:0) after 1m0s
[10:10:01.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:138:0)
[10:10:01.583] Timer tick, asking Buildbucket for the build status
[10:10:01.730] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:01.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:139:0) after 1m0s
[10:11:01.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:139:0)
[10:11:01.817] Timer tick, asking Buildbucket for the build status
[10:11:02.022] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:02.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:140:0) after 1m0s
[10:12:02.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:140:0)
[10:12:02.083] Timer tick, asking Buildbucket for the build status
[10:12:02.249] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:02.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:141:0) after 1m0s
[10:13:02.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:141:0)
[10:13:02.275] Timer tick, asking Buildbucket for the build status
[10:13:02.335] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:02.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:142:0) after 1m0s
[10:14:02.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:142:0)
[10:14:02.398] Timer tick, asking Buildbucket for the build status
[10:14:02.598] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:02.598] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:143:0) after 1m0s
[10:15:02.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:143:0)
[10:15:02.680] Timer tick, asking Buildbucket for the build status
[10:15:02.923] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:02.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:144:0) after 1m0s
[10:16:02.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:144:0)
[10:16:02.949] Timer tick, asking Buildbucket for the build status
[10:16:03.167] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:03.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:145:0) after 1m0s
[10:17:03.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:145:0)
[10:17:03.205] Timer tick, asking Buildbucket for the build status
[10:17:03.297] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:03.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:146:0) after 1m0s
[10:18:03.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:146:0)
[10:18:03.328] Timer tick, asking Buildbucket for the build status
[10:18:03.445] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:03.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:147:0) after 1m0s
[10:19:03.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:147:0)
[10:19:03.482] Timer tick, asking Buildbucket for the build status
[10:19:03.890] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:03.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:148:0) after 1m0s
[10:20:03.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:148:0)
[10:20:03.935] Timer tick, asking Buildbucket for the build status
[10:20:04.196] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:04.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:149:0) after 1m0s
[10:21:04.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:149:0)
[10:21:04.200] Timer tick, asking Buildbucket for the build status
[10:21:04.621] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:04.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:150:0) after 1m0s
[10:22:04.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:150:0)
[10:22:04.713] Timer tick, asking Buildbucket for the build status
[10:22:04.792] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:04.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:151:0) after 1m0s
[10:23:04.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:151:0)
[10:23:04.884] Timer tick, asking Buildbucket for the build status
[10:23:04.996] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:04.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:152:0) after 1m0s
[10:24:05.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:152:0)
[10:24:05.150] Timer tick, asking Buildbucket for the build status
[10:24:05.490] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:05.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:153:0) after 1m0s
[10:25:05.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:153:0)
[10:25:05.545] Timer tick, asking Buildbucket for the build status
[10:25:05.726] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:05.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:154:0) after 1m0s
[10:26:05.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:154:0)
[10:26:05.752] Timer tick, asking Buildbucket for the build status
[10:26:05.928] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:05.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:155:0) after 1m0s
[10:27:06.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:155:0)
[10:27:06.004] Timer tick, asking Buildbucket for the build status
[10:27:06.118] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:06.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:156:0) after 1m0s
[10:28:06.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:156:0)
[10:28:06.146] Timer tick, asking Buildbucket for the build status
[10:28:06.209] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:06.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:157:0) after 1m0s
[10:29:06.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:157:0)
[10:29:06.288] Timer tick, asking Buildbucket for the build status
[10:29:06.480] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:06.480] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:158:0) after 1m0s
[10:30:06.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:158:0)
[10:30:06.532] Timer tick, asking Buildbucket for the build status
[10:30:06.614] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:06.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:159:0) after 1m0s
[10:31:06.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:159:0)
[10:31:06.633] Timer tick, asking Buildbucket for the build status
[10:31:06.740] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:06.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:160:0) after 1m0s
[10:32:06.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:160:0)
[10:32:06.774] Timer tick, asking Buildbucket for the build status
[10:32:06.894] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:06.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:161:0) after 1m0s
[10:33:06.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:161:0)
[10:33:06.932] Timer tick, asking Buildbucket for the build status
[10:33:07.038] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:07.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:162:0) after 1m0s
[10:34:07.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:162:0)
[10:34:07.107] Timer tick, asking Buildbucket for the build status
[10:34:07.250] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:07.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:163:0) after 1m0s
[10:35:07.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:163:0)
[10:35:07.275] Timer tick, asking Buildbucket for the build status
[10:35:07.361] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:07.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:164:0) after 1m0s
[10:36:07.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:164:0)
[10:36:07.388] Timer tick, asking Buildbucket for the build status
[10:36:07.521] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:07.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:165:0) after 1m0s
[10:37:07.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:165:0)
[10:37:07.591] Timer tick, asking Buildbucket for the build status
[10:37:07.670] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:07.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:166:0) after 1m0s
[10:38:07.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:166:0)
[10:38:07.816] Timer tick, asking Buildbucket for the build status
[10:38:08.192] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:08.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:167:0) after 1m0s
[10:39:08.332] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:167:0)
[10:39:08.332] Timer tick, asking Buildbucket for the build status
[10:39:08.511] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:08.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:168:0) after 1m0s
[10:40:08.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:168:0)
[10:40:08.549] Timer tick, asking Buildbucket for the build status
[10:40:08.622] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:08.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:169:0) after 1m0s
[10:41:08.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:169:0)
[10:41:08.655] Timer tick, asking Buildbucket for the build status
[10:41:08.721] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:08.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:170:0) after 1m0s
[10:42:08.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:170:0)
[10:42:08.777] Timer tick, asking Buildbucket for the build status
[10:42:08.851] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:08.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:171:0) after 1m0s
[10:43:08.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:171:0)
[10:43:08.883] Timer tick, asking Buildbucket for the build status
[10:43:09.665] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:09.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:172:0) after 1m0s
[10:44:09.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:172:0)
[10:44:09.698] Timer tick, asking Buildbucket for the build status
[10:44:10.016] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:10.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:173:0) after 1m0s
[10:45:10.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:173:0)
[10:45:10.182] Timer tick, asking Buildbucket for the build status
[10:45:10.353] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:10.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:174:0) after 1m0s
[10:46:10.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:174:0)
[10:46:10.365] Timer tick, asking Buildbucket for the build status
[10:46:10.433] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:10.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:175:0) after 1m0s
[10:47:10.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:175:0)
[10:47:10.533] Timer tick, asking Buildbucket for the build status
[10:47:10.828] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:10.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:176:0) after 1m0s
[10:48:10.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:176:0)
[10:48:10.818] Timer tick, asking Buildbucket for the build status
[10:48:10.894] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:10.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:177:0) after 1m0s
[10:49:10.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:177:0)
[10:49:10.931] Timer tick, asking Buildbucket for the build status
[10:49:11.336] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:11.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:178:0) after 1m0s
[10:50:11.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:178:0)
[10:50:11.424] Timer tick, asking Buildbucket for the build status
[10:50:11.483] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:11.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:179:0) after 1m0s
[10:51:11.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:179:0)
[10:51:11.557] Timer tick, asking Buildbucket for the build status
[10:51:11.842] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:11.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:180:0) after 1m0s
[10:52:11.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:180:0)
[10:52:11.919] Timer tick, asking Buildbucket for the build status
[10:52:12.012] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:12.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:181:0) after 1m0s
[10:53:12.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:181:0)
[10:53:12.041] Timer tick, asking Buildbucket for the build status
[10:53:12.108] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:12.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:182:0) after 1m0s
[10:54:12.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:182:0)
[10:54:12.142] Timer tick, asking Buildbucket for the build status
[10:54:12.356] Build 8871916636883856528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:12.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037346699404837536:183:0) after 1m0s
[10:54:43.967] Received PubSub notification, asking Buildbucket for the build status
[10:54:44.098] Build 8871916636883856528: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:54:44.098] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1597488883153841",
    "created_by": "project:infra",
    "created_ts": "1597477988314084",
    "id": "8871916636883856528",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4234.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f49a6817-8f28-458b-98b1-881980594ad2\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4234.0\"}}",
    "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-7q02\"], \"image\": [\"chrome-xenial-20081300-1358d8153ce\"], \"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\": [\"5488-fc78d20\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1597477999564970",
    "status": "COMPLETED",
    "status_changed_ts": "1597488883572467",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9037346699404837536",
      "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/8871916636883856528/+/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:4e09ed367db6e210",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1597488883593283",
    "url": "https://ci.chromium.org/b/8871916636883856528",
    "utcnow_ts": "1597488884085365"
  }
}
[10:54:44.098] Invocation finished in 3h1m37.571913233s with status SUCCEEDED