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

• parent_buildername:publish_tarball
• user_agent:recipe

[08:52:50.475] New invocation is queued and will start shortly
[08:52:50.475] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:52:51.579] Starting the invocation (attempt 1)
[08:52:51.653] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:52:51.653] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:52:51.653] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9026743096311178880",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4324.39\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"6e927a61-691a-430b-849d-f2b387cb4af8\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4324.39\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9026743096311178880",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[08:52:52.189] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1607590371774504",
    "id": "8861313034284827424",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4324.39\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"6e927a61-691a-430b-849d-f2b387cb4af8\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4324.39\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1607590371962698",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9026743096311178880",
      "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/8861313034284827424/+/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": "1607590371962813",
    "url": "https://ci.chromium.org/b/8861313034284827424",
    "utcnow_ts": "1607590372179850"
  }
}
[08:52:52.189] Task URL: https://ci.chromium.org/b/8861313034284827424
[08:52:52.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:2:0) after 1m0s
[08:53:36.096] Received PubSub notification, asking Buildbucket for the build status
[08:53:36.307] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:52.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:2:0)
[08:53:52.425] Timer tick, asking Buildbucket for the build status
[08:53:52.504] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:52.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:4:0) after 1m0s
[08:54:52.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:4:0)
[08:54:52.669] Timer tick, asking Buildbucket for the build status
[08:54:53.005] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:53.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:5:0) after 1m0s
[08:55:53.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:5:0)
[08:55:53.149] Timer tick, asking Buildbucket for the build status
[08:55:53.268] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:53.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:6:0) after 1m0s
[08:56:53.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:6:0)
[08:56:53.346] Timer tick, asking Buildbucket for the build status
[08:56:53.512] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:53.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:7:0) after 1m0s
[08:57:53.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:7:0)
[08:57:53.634] Timer tick, asking Buildbucket for the build status
[08:57:53.734] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:53.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:8:0) after 1m0s
[08:58:54.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:8:0)
[08:58:54.473] Timer tick, asking Buildbucket for the build status
[08:58:54.535] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:54.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:9:0) after 1m0s
[08:59:54.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:9:0)
[08:59:54.581] Timer tick, asking Buildbucket for the build status
[08:59:54.644] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:54.644] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:10:0) after 1m0s
[09:00:54.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:10:0)
[09:00:54.743] Timer tick, asking Buildbucket for the build status
[09:00:54.839] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:54.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:11:0) after 1m0s
[09:01:54.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:11:0)
[09:01:54.840] Timer tick, asking Buildbucket for the build status
[09:01:55.109] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:55.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:12:0) after 1m0s
[09:02:55.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:12:0)
[09:02:55.128] Timer tick, asking Buildbucket for the build status
[09:02:55.216] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:55.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:13:0) after 1m0s
[09:03:55.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:13:0)
[09:03:55.257] Timer tick, asking Buildbucket for the build status
[09:03:55.423] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:55.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:14:0) after 1m0s
[09:04:55.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:14:0)
[09:04:55.441] Timer tick, asking Buildbucket for the build status
[09:04:55.687] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:55.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:15:0) after 1m0s
[09:05:55.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:15:0)
[09:05:55.769] Timer tick, asking Buildbucket for the build status
[09:05:55.825] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:55.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:16:0) after 1m0s
[09:06:56.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:16:0)
[09:06:56.682] Timer tick, asking Buildbucket for the build status
[09:06:56.740] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:56.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:17:0) after 1m0s
[09:07:56.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:17:0)
[09:07:56.783] Timer tick, asking Buildbucket for the build status
[09:07:56.872] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:56.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:18:0) after 1m0s
[09:08:56.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:18:0)
[09:08:56.965] Timer tick, asking Buildbucket for the build status
[09:08:57.024] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:57.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:19:0) after 1m0s
[09:09:57.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:19:0)
[09:09:57.163] Timer tick, asking Buildbucket for the build status
[09:09:57.231] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:57.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:20:0) after 1m0s
[09:10:57.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:20:0)
[09:10:57.255] Timer tick, asking Buildbucket for the build status
[09:10:57.314] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:57.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:21:0) after 1m0s
[09:11:57.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:21:0)
[09:11:57.392] Timer tick, asking Buildbucket for the build status
[09:11:57.709] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:57.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:22:0) after 1m0s
[09:12:57.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:22:0)
[09:12:57.732] Timer tick, asking Buildbucket for the build status
[09:12:57.824] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:57.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:23:0) after 1m0s
[09:13:57.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:23:0)
[09:13:57.871] Timer tick, asking Buildbucket for the build status
[09:13:57.933] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:57.934] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:24:0) after 1m0s
[09:14:57.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:24:0)
[09:14:57.956] Timer tick, asking Buildbucket for the build status
[09:14:58.016] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:58.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:25:0) after 1m0s
[09:15:58.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:25:0)
[09:15:58.085] Timer tick, asking Buildbucket for the build status
[09:15:58.137] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:58.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:26:0) after 1m0s
[09:16:58.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:26:0)
[09:16:58.184] Timer tick, asking Buildbucket for the build status
[09:16:58.248] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:58.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:27:0) after 1m0s
[09:17:58.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:27:0)
[09:17:58.266] Timer tick, asking Buildbucket for the build status
[09:17:58.375] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:58.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:28:0) after 1m0s
[09:18:58.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:28:0)
[09:18:58.444] Timer tick, asking Buildbucket for the build status
[09:18:58.515] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:58.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:29:0) after 1m0s
[09:19:58.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:29:0)
[09:19:58.535] Timer tick, asking Buildbucket for the build status
[09:19:58.592] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:58.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:30:0) after 1m0s
[09:20:58.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:30:0)
[09:20:58.635] Timer tick, asking Buildbucket for the build status
[09:20:58.694] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:58.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:31:0) after 1m0s
[09:21:58.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:31:0)
[09:21:58.717] Timer tick, asking Buildbucket for the build status
[09:21:58.773] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:58.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:32:0) after 1m0s
[09:22:58.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:32:0)
[09:22:58.798] Timer tick, asking Buildbucket for the build status
[09:22:58.911] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:58.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:33:0) after 1m0s
[09:23:58.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:33:0)
[09:23:58.983] Timer tick, asking Buildbucket for the build status
[09:23:59.039] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:59.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:34:0) after 1m0s
[09:24:59.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:34:0)
[09:24:59.078] Timer tick, asking Buildbucket for the build status
[09:24:59.142] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:59.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:35:0) after 1m0s
[09:25:59.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:35:0)
[09:25:59.184] Timer tick, asking Buildbucket for the build status
[09:25:59.404] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:59.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:36:0) after 1m0s
[09:26:59.443] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:36:0)
[09:26:59.443] Timer tick, asking Buildbucket for the build status
[09:26:59.498] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:59.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:37:0) after 1m0s
[09:27:59.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:37:0)
[09:27:59.519] Timer tick, asking Buildbucket for the build status
[09:27:59.618] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:59.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:38:0) after 1m0s
[09:28:59.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:38:0)
[09:28:59.646] Timer tick, asking Buildbucket for the build status
[09:28:59.708] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:59.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:39:0) after 1m0s
[09:29:59.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:39:0)
[09:29:59.711] Timer tick, asking Buildbucket for the build status
[09:29:59.782] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:59.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:40:0) after 1m0s
[09:30:59.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:40:0)
[09:30:59.763] Timer tick, asking Buildbucket for the build status
[09:30:59.827] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:59.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:41:0) after 1m0s
[09:31:59.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:41:0)
[09:31:59.884] Timer tick, asking Buildbucket for the build status
[09:31:59.987] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:59.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:42:0) after 1m0s
[09:33:00.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:42:0)
[09:33:00.012] Timer tick, asking Buildbucket for the build status
[09:33:00.307] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:00.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:43:0) after 1m0s
[09:34:01.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:43:0)
[09:34:01.074] Timer tick, asking Buildbucket for the build status
[09:34:01.174] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:01.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:44:0) after 1m0s
[09:35:01.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:44:0)
[09:35:01.157] Timer tick, asking Buildbucket for the build status
[09:35:01.261] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:01.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:45:0) after 1m0s
[09:36:01.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:45:0)
[09:36:01.495] Timer tick, asking Buildbucket for the build status
[09:36:01.725] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:01.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:46:0) after 1m0s
[09:37:01.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:46:0)
[09:37:01.907] Timer tick, asking Buildbucket for the build status
[09:37:02.085] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:02.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:47:0) after 1m0s
[09:38:02.170] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:47:0)
[09:38:02.171] Timer tick, asking Buildbucket for the build status
[09:38:02.550] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:02.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:48:0) after 1m0s
[09:39:02.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:48:0)
[09:39:02.558] Timer tick, asking Buildbucket for the build status
[09:39:02.840] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:02.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:49:0) after 1m0s
[09:40:02.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:49:0)
[09:40:02.865] Timer tick, asking Buildbucket for the build status
[09:40:02.962] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:02.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:50:0) after 1m0s
[09:41:02.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:50:0)
[09:41:02.985] Timer tick, asking Buildbucket for the build status
[09:41:03.147] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:03.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:51:0) after 1m0s
[09:42:03.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:51:0)
[09:42:03.218] Timer tick, asking Buildbucket for the build status
[09:42:03.401] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:03.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:52:0) after 1m0s
[09:43:03.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:52:0)
[09:43:03.428] Timer tick, asking Buildbucket for the build status
[09:43:03.551] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:03.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:53:0) after 1m0s
[09:44:03.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:53:0)
[09:44:03.573] Timer tick, asking Buildbucket for the build status
[09:44:03.656] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:03.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:54:0) after 1m0s
[09:45:03.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:54:0)
[09:45:03.694] Timer tick, asking Buildbucket for the build status
[09:45:03.776] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:03.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:55:0) after 1m0s
[09:46:03.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:55:0)
[09:46:03.836] Timer tick, asking Buildbucket for the build status
[09:46:03.905] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:03.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:56:0) after 1m0s
[09:47:03.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:56:0)
[09:47:03.921] Timer tick, asking Buildbucket for the build status
[09:47:03.975] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:03.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:57:0) after 1m0s
[09:48:04.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:57:0)
[09:48:04.012] Timer tick, asking Buildbucket for the build status
[09:48:04.196] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:04.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:58:0) after 1m0s
[09:49:04.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:58:0)
[09:49:04.217] Timer tick, asking Buildbucket for the build status
[09:49:04.325] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:04.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:59:0) after 1m0s
[09:50:04.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:59:0)
[09:50:04.365] Timer tick, asking Buildbucket for the build status
[09:50:04.423] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:04.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:60:0) after 1m0s
[09:51:04.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:60:0)
[09:51:04.479] Timer tick, asking Buildbucket for the build status
[09:51:04.539] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:04.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:61:0) after 1m0s
[09:52:04.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:61:0)
[09:52:04.555] Timer tick, asking Buildbucket for the build status
[09:52:04.642] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:04.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:62:0) after 1m0s
[09:53:04.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:62:0)
[09:53:04.667] Timer tick, asking Buildbucket for the build status
[09:53:04.823] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:04.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:63:0) after 1m0s
[09:54:04.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:63:0)
[09:54:04.983] Timer tick, asking Buildbucket for the build status
[09:54:05.046] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:05.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:64:0) after 1m0s
[09:55:05.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:64:0)
[09:55:05.209] Timer tick, asking Buildbucket for the build status
[09:55:05.269] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:05.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:65:0) after 1m0s
[09:56:05.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:65:0)
[09:56:05.290] Timer tick, asking Buildbucket for the build status
[09:56:05.346] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:05.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:66:0) after 1m0s
[09:57:05.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:66:0)
[09:57:05.368] Timer tick, asking Buildbucket for the build status
[09:57:05.429] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:05.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:67:0) after 1m0s
[09:58:05.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:67:0)
[09:58:05.459] Timer tick, asking Buildbucket for the build status
[09:58:05.564] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:05.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:68:0) after 1m0s
[09:59:05.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:68:0)
[09:59:05.601] Timer tick, asking Buildbucket for the build status
[09:59:05.651] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:05.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:69:0) after 1m0s
[10:00:05.663] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:69:0)
[10:00:05.663] Timer tick, asking Buildbucket for the build status
[10:00:05.895] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:05.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:70:0) after 1m0s
[10:01:06.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:70:0)
[10:01:06.309] Timer tick, asking Buildbucket for the build status
[10:01:06.477] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:06.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:71:0) after 1m0s
[10:02:06.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:71:0)
[10:02:06.566] Timer tick, asking Buildbucket for the build status
[10:02:06.699] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:06.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:72:0) after 1m0s
[10:03:06.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:72:0)
[10:03:06.927] Timer tick, asking Buildbucket for the build status
[10:03:07.199] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:07.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:73:0) after 1m0s
[10:04:07.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:73:0)
[10:04:07.411] Timer tick, asking Buildbucket for the build status
[10:04:07.473] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:07.473] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:74:0) after 1m0s
[10:05:07.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:74:0)
[10:05:07.646] Timer tick, asking Buildbucket for the build status
[10:05:07.737] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:07.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:75:0) after 1m0s
[10:06:07.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:75:0)
[10:06:07.738] Timer tick, asking Buildbucket for the build status
[10:06:07.794] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:07.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:76:0) after 1m0s
[10:07:07.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:76:0)
[10:07:07.886] Timer tick, asking Buildbucket for the build status
[10:07:07.943] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:07.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:77:0) after 1m0s
[10:08:07.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:77:0)
[10:08:07.983] Timer tick, asking Buildbucket for the build status
[10:08:08.107] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:08.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:78:0) after 1m0s
[10:09:08.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:78:0)
[10:09:08.167] Timer tick, asking Buildbucket for the build status
[10:09:08.301] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:08.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:79:0) after 1m0s
[10:10:08.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:79:0)
[10:10:08.324] Timer tick, asking Buildbucket for the build status
[10:10:08.444] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:08.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:80:0) after 1m0s
[10:11:08.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:80:0)
[10:11:08.469] Timer tick, asking Buildbucket for the build status
[10:11:08.529] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:08.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:81:0) after 1m0s
[10:12:08.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:81:0)
[10:12:08.570] Timer tick, asking Buildbucket for the build status
[10:12:08.643] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:08.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:82:0) after 1m0s
[10:13:08.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:82:0)
[10:13:08.674] Timer tick, asking Buildbucket for the build status
[10:13:08.768] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:08.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:83:0) after 1m0s
[10:14:08.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:83:0)
[10:14:08.800] Timer tick, asking Buildbucket for the build status
[10:14:08.870] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:08.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:84:0) after 1m0s
[10:15:08.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:84:0)
[10:15:08.884] Timer tick, asking Buildbucket for the build status
[10:15:08.942] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:08.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:85:0) after 1m0s
[10:16:09.010] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:85:0)
[10:16:09.010] Timer tick, asking Buildbucket for the build status
[10:16:09.070] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:09.070] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:86:0) after 1m0s
[10:17:09.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:86:0)
[10:17:09.101] Timer tick, asking Buildbucket for the build status
[10:17:09.163] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:09.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:87:0) after 1m0s
[10:18:09.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:87:0)
[10:18:09.227] Timer tick, asking Buildbucket for the build status
[10:18:09.542] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:09.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:88:0) after 1m0s
[10:19:09.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:88:0)
[10:19:09.603] Timer tick, asking Buildbucket for the build status
[10:19:09.672] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:09.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:89:0) after 1m0s
[10:20:09.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:89:0)
[10:20:09.734] Timer tick, asking Buildbucket for the build status
[10:20:09.850] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:09.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:90:0) after 1m0s
[10:21:09.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:90:0)
[10:21:09.875] Timer tick, asking Buildbucket for the build status
[10:21:09.964] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:09.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:91:0) after 1m0s
[10:22:09.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:91:0)
[10:22:09.993] Timer tick, asking Buildbucket for the build status
[10:22:10.068] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:10.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:92:0) after 1m0s
[10:23:10.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:92:0)
[10:23:10.092] Timer tick, asking Buildbucket for the build status
[10:23:10.518] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:10.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:93:0) after 1m0s
[10:24:10.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:93:0)
[10:24:10.577] Timer tick, asking Buildbucket for the build status
[10:24:10.807] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:10.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:94:0) after 1m0s
[10:25:10.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:94:0)
[10:25:10.947] Timer tick, asking Buildbucket for the build status
[10:25:11.019] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:11.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:95:0) after 1m0s
[10:26:11.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:95:0)
[10:26:11.002] Timer tick, asking Buildbucket for the build status
[10:26:11.311] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:11.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:96:0) after 1m0s
[10:27:11.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:96:0)
[10:27:11.339] Timer tick, asking Buildbucket for the build status
[10:27:11.407] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:11.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:97:0) after 1m0s
[10:28:11.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:97:0)
[10:28:11.441] Timer tick, asking Buildbucket for the build status
[10:28:11.798] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:11.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:98:0) after 1m0s
[10:29:11.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:98:0)
[10:29:11.851] Timer tick, asking Buildbucket for the build status
[10:29:11.924] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:11.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:99:0) after 1m0s
[10:30:11.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:99:0)
[10:30:11.995] Timer tick, asking Buildbucket for the build status
[10:30:12.693] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:12.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:100:0) after 1m0s
[10:31:12.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:100:0)
[10:31:12.896] Timer tick, asking Buildbucket for the build status
[10:31:12.962] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:12.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:101:0) after 1m0s
[10:32:12.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:101:0)
[10:32:12.996] Timer tick, asking Buildbucket for the build status
[10:32:13.057] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:13.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:102:0) after 1m0s
[10:33:13.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:102:0)
[10:33:13.176] Timer tick, asking Buildbucket for the build status
[10:33:13.295] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:13.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:103:0) after 1m0s
[10:34:13.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:103:0)
[10:34:13.382] Timer tick, asking Buildbucket for the build status
[10:34:13.595] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:13.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:104:0) after 1m0s
[10:35:13.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:104:0)
[10:35:13.654] Timer tick, asking Buildbucket for the build status
[10:35:13.725] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:13.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:105:0) after 1m0s
[10:36:13.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:105:0)
[10:36:13.758] Timer tick, asking Buildbucket for the build status
[10:36:13.813] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:13.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:106:0) after 1m0s
[10:37:13.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:106:0)
[10:37:13.902] Timer tick, asking Buildbucket for the build status
[10:37:13.957] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:13.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:107:0) after 1m0s
[10:38:14.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:107:0)
[10:38:14.008] Timer tick, asking Buildbucket for the build status
[10:38:14.119] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:14.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:108:0) after 1m0s
[10:39:14.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:108:0)
[10:39:14.114] Timer tick, asking Buildbucket for the build status
[10:39:14.176] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:14.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:109:0) after 1m0s
[10:40:14.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:109:0)
[10:40:14.271] Timer tick, asking Buildbucket for the build status
[10:40:14.347] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:14.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:110:0) after 1m0s
[10:41:14.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:110:0)
[10:41:14.452] Timer tick, asking Buildbucket for the build status
[10:41:14.603] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:14.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:111:0) after 1m0s
[10:42:14.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:111:0)
[10:42:14.651] Timer tick, asking Buildbucket for the build status
[10:42:14.968] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:14.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:112:0) after 1m0s
[10:43:15.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:112:0)
[10:43:15.067] Timer tick, asking Buildbucket for the build status
[10:43:15.481] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:15.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:113:0) after 1m0s
[10:44:15.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:113:0)
[10:44:15.497] Timer tick, asking Buildbucket for the build status
[10:44:15.889] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:15.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:114:0) after 1m0s
[10:45:16.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:114:0)
[10:45:16.018] Timer tick, asking Buildbucket for the build status
[10:45:16.202] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:16.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:115:0) after 1m0s
[10:46:16.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:115:0)
[10:46:16.306] Timer tick, asking Buildbucket for the build status
[10:46:16.419] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:16.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:116:0) after 1m0s
[10:47:16.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:116:0)
[10:47:16.478] Timer tick, asking Buildbucket for the build status
[10:47:16.563] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:16.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:117:0) after 1m0s
[10:48:16.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:117:0)
[10:48:16.624] Timer tick, asking Buildbucket for the build status
[10:48:17.045] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:17.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:118:0) after 1m0s
[10:49:17.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:118:0)
[10:49:17.063] Timer tick, asking Buildbucket for the build status
[10:49:17.123] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:17.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:119:0) after 1m0s
[10:50:17.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:119:0)
[10:50:17.178] Timer tick, asking Buildbucket for the build status
[10:50:17.236] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:17.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:120:0) after 1m0s
[10:51:17.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:120:0)
[10:51:17.226] Timer tick, asking Buildbucket for the build status
[10:51:17.277] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:17.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:121:0) after 1m0s
[10:52:17.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:121:0)
[10:52:17.314] Timer tick, asking Buildbucket for the build status
[10:52:17.371] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:17.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:122:0) after 1m0s
[10:53:17.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:122:0)
[10:53:17.432] Timer tick, asking Buildbucket for the build status
[10:53:17.529] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:17.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:123:0) after 1m0s
[10:54:17.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:123:0)
[10:54:17.583] Timer tick, asking Buildbucket for the build status
[10:54:17.659] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:17.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:124:0) after 1m0s
[10:55:17.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:124:0)
[10:55:17.722] Timer tick, asking Buildbucket for the build status
[10:55:17.839] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:17.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:125:0) after 1m0s
[10:56:17.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:125:0)
[10:56:17.886] Timer tick, asking Buildbucket for the build status
[10:56:18.029] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:18.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:126:0) after 1m0s
[10:57:18.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:126:0)
[10:57:18.096] Timer tick, asking Buildbucket for the build status
[10:57:18.153] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:18.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:127:0) after 1m0s
[10:58:18.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:127:0)
[10:58:18.245] Timer tick, asking Buildbucket for the build status
[10:58:18.354] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:18.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:128:0) after 1m0s
[10:59:18.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:128:0)
[10:59:18.406] Timer tick, asking Buildbucket for the build status
[10:59:18.504] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:18.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:129:0) after 1m0s
[11:00:18.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:129:0)
[11:00:18.641] Timer tick, asking Buildbucket for the build status
[11:00:18.787] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:18.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:130:0) after 1m0s
[11:01:18.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:130:0)
[11:01:18.940] Timer tick, asking Buildbucket for the build status
[11:01:19.008] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:19.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:131:0) after 1m0s
[11:02:19.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:131:0)
[11:02:19.199] Timer tick, asking Buildbucket for the build status
[11:02:19.324] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:19.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:132:0) after 1m0s
[11:03:19.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:132:0)
[11:03:19.396] Timer tick, asking Buildbucket for the build status
[11:03:19.682] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:19.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:133:0) after 1m0s
[11:04:19.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:133:0)
[11:04:19.785] Timer tick, asking Buildbucket for the build status
[11:04:19.912] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:19.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:134:0) after 1m0s
[11:05:19.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:134:0)
[11:05:19.971] Timer tick, asking Buildbucket for the build status
[11:05:20.150] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:20.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:135:0) after 1m0s
[11:06:20.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:135:0)
[11:06:20.594] Timer tick, asking Buildbucket for the build status
[11:06:20.665] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:20.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:136:0) after 1m0s
[11:07:20.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:136:0)
[11:07:20.827] Timer tick, asking Buildbucket for the build status
[11:07:21.086] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:21.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:137:0) after 1m0s
[11:08:21.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:137:0)
[11:08:21.158] Timer tick, asking Buildbucket for the build status
[11:08:21.264] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:21.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:138:0) after 1m0s
[11:09:21.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:138:0)
[11:09:21.355] Timer tick, asking Buildbucket for the build status
[11:09:21.647] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:21.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:139:0) after 1m0s
[11:10:21.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:139:0)
[11:10:21.707] Timer tick, asking Buildbucket for the build status
[11:10:21.760] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:21.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:140:0) after 1m0s
[11:11:21.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:140:0)
[11:11:21.853] Timer tick, asking Buildbucket for the build status
[11:11:21.918] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:21.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:141:0) after 1m0s
[11:12:22.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:141:0)
[11:12:22.029] Timer tick, asking Buildbucket for the build status
[11:12:22.402] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:22.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:142:0) after 1m0s
[11:13:22.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:142:0)
[11:13:22.502] Timer tick, asking Buildbucket for the build status
[11:13:22.733] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:22.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:143:0) after 1m0s
[11:14:22.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:143:0)
[11:14:22.795] Timer tick, asking Buildbucket for the build status
[11:14:22.850] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:22.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:144:0) after 1m0s
[11:15:22.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:144:0)
[11:15:22.847] Timer tick, asking Buildbucket for the build status
[11:15:22.910] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:22.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:145:0) after 1m0s
[11:16:22.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:145:0)
[11:16:22.963] Timer tick, asking Buildbucket for the build status
[11:16:23.028] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:23.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:146:0) after 1m0s
[11:17:23.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:146:0)
[11:17:23.117] Timer tick, asking Buildbucket for the build status
[11:17:23.246] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:23.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:147:0) after 1m0s
[11:18:23.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:147:0)
[11:18:23.257] Timer tick, asking Buildbucket for the build status
[11:18:23.374] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:23.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:148:0) after 1m0s
[11:19:23.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:148:0)
[11:19:23.440] Timer tick, asking Buildbucket for the build status
[11:19:23.613] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:23.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:149:0) after 1m0s
[11:20:23.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:149:0)
[11:20:23.709] Timer tick, asking Buildbucket for the build status
[11:20:23.765] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:23.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:150:0) after 1m0s
[11:21:23.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:150:0)
[11:21:23.866] Timer tick, asking Buildbucket for the build status
[11:21:23.922] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:23.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:151:0) after 1m0s
[11:22:24.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:151:0)
[11:22:24.018] Timer tick, asking Buildbucket for the build status
[11:22:24.201] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:24.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:152:0) after 1m0s
[11:23:24.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:152:0)
[11:23:24.193] Timer tick, asking Buildbucket for the build status
[11:23:24.664] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:24.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:153:0) after 1m0s
[11:24:24.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:153:0)
[11:24:24.687] Timer tick, asking Buildbucket for the build status
[11:24:24.838] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:24.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:154:0) after 1m0s
[11:25:24.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:154:0)
[11:25:24.898] Timer tick, asking Buildbucket for the build status
[11:25:24.951] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:24.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:155:0) after 1m0s
[11:26:24.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:155:0)
[11:26:24.971] Timer tick, asking Buildbucket for the build status
[11:26:25.029] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:25.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:156:0) after 1m0s
[11:27:25.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:156:0)
[11:27:25.059] Timer tick, asking Buildbucket for the build status
[11:27:25.122] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:25.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:157:0) after 1m0s
[11:28:25.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:157:0)
[11:28:25.177] Timer tick, asking Buildbucket for the build status
[11:28:25.327] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:25.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:158:0) after 1m0s
[11:29:25.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:158:0)
[11:29:25.368] Timer tick, asking Buildbucket for the build status
[11:29:25.446] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:25.446] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:159:0) after 1m0s
[11:30:25.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:159:0)
[11:30:25.481] Timer tick, asking Buildbucket for the build status
[11:30:26.015] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:26.015] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:160:0) after 1m0s
[11:31:26.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:160:0)
[11:31:26.043] Timer tick, asking Buildbucket for the build status
[11:31:26.104] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:26.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:161:0) after 1m0s
[11:32:26.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:161:0)
[11:32:26.173] Timer tick, asking Buildbucket for the build status
[11:32:26.374] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:26.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:162:0) after 1m0s
[11:33:26.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:162:0)
[11:33:26.397] Timer tick, asking Buildbucket for the build status
[11:33:26.701] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:26.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:163:0) after 1m0s
[11:34:26.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:163:0)
[11:34:26.739] Timer tick, asking Buildbucket for the build status
[11:34:26.802] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:26.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:164:0) after 1m0s
[11:35:26.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:164:0)
[11:35:26.797] Timer tick, asking Buildbucket for the build status
[11:35:26.851] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:26.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:165:0) after 1m0s
[11:36:26.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:165:0)
[11:36:26.866] Timer tick, asking Buildbucket for the build status
[11:36:26.928] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:26.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:166:0) after 1m0s
[11:37:26.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:166:0)
[11:37:26.998] Timer tick, asking Buildbucket for the build status
[11:37:27.182] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:27.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:167:0) after 1m0s
[11:38:27.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:167:0)
[11:38:27.314] Timer tick, asking Buildbucket for the build status
[11:38:27.471] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:27.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:168:0) after 1m0s
[11:39:27.630] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:168:0)
[11:39:27.630] Timer tick, asking Buildbucket for the build status
[11:39:27.794] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:27.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:169:0) after 1m0s
[11:40:27.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:169:0)
[11:40:27.887] Timer tick, asking Buildbucket for the build status
[11:40:27.959] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:27.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:170:0) after 1m0s
[11:41:28.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:170:0)
[11:41:28.000] Timer tick, asking Buildbucket for the build status
[11:41:28.065] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:28.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:171:0) after 1m0s
[11:42:28.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:171:0)
[11:42:28.126] Timer tick, asking Buildbucket for the build status
[11:42:28.191] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:28.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:172:0) after 1m0s
[11:43:28.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:172:0)
[11:43:28.206] Timer tick, asking Buildbucket for the build status
[11:43:28.318] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:28.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:173:0) after 1m0s
[11:44:28.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:173:0)
[11:44:28.410] Timer tick, asking Buildbucket for the build status
[11:44:28.464] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:28.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:174:0) after 1m0s
[11:45:28.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:174:0)
[11:45:28.520] Timer tick, asking Buildbucket for the build status
[11:45:28.626] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:28.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:175:0) after 1m0s
[11:46:28.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:175:0)
[11:46:28.647] Timer tick, asking Buildbucket for the build status
[11:46:28.719] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:28.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:176:0) after 1m0s
[11:47:28.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:176:0)
[11:47:28.721] Timer tick, asking Buildbucket for the build status
[11:47:28.825] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:28.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:177:0) after 1m0s
[11:48:28.855] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:177:0)
[11:48:28.855] Timer tick, asking Buildbucket for the build status
[11:48:28.964] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:28.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:178:0) after 1m0s
[11:49:29.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:178:0)
[11:49:29.028] Timer tick, asking Buildbucket for the build status
[11:49:29.097] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:29.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:179:0) after 1m0s
[11:50:29.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:179:0)
[11:50:29.167] Timer tick, asking Buildbucket for the build status
[11:50:29.522] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:29.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:180:0) after 1m0s
[11:51:29.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:180:0)
[11:51:29.574] Timer tick, asking Buildbucket for the build status
[11:51:29.650] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:29.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:181:0) after 1m0s
[11:52:29.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:181:0)
[11:52:29.710] Timer tick, asking Buildbucket for the build status
[11:52:29.778] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:29.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:182:0) after 1m0s
[11:53:29.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:182:0)
[11:53:29.806] Timer tick, asking Buildbucket for the build status
[11:53:29.909] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:29.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:183:0) after 1m0s
[11:54:30.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:183:0)
[11:54:30.008] Timer tick, asking Buildbucket for the build status
[11:54:30.073] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:30.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:184:0) after 1m0s
[11:55:30.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:184:0)
[11:55:30.106] Timer tick, asking Buildbucket for the build status
[11:55:30.222] Build 8861313034284827424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:30.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9026743096311178880:185:0) after 1m0s
[11:55:37.439] Received PubSub notification, asking Buildbucket for the build status
[11:55:37.494] Build 8861313034284827424: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:55:37.495] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1607601336234675",
    "created_by": "project:infra",
    "created_ts": "1607590371774504",
    "id": "8861313034284827424",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4324.39\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"6e927a61-691a-430b-849d-f2b387cb4af8\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4324.39\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2cef80c29081f5c9c0eae6fce4d1cfa8225be4f2dafcd9d34a2d1ba79d042c0f_v2\", \"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-9qiq\"], \"image\": [\"chrome-xenial-20120600-c5cfbe11ce8\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1607590415023488",
    "status": "COMPLETED",
    "status_changed_ts": "1607601336526119",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9026743096311178880",
      "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/8861313034284827424/+/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:5064abebd4598210",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1607601336538847",
    "url": "https://ci.chromium.org/b/8861313034284827424",
    "utcnow_ts": "1607601337485469"
  }
}
[11:55:37.495] Invocation finished in 3h2m47.036482666s with status SUCCEEDED