Status: SUCCEEDED
Triggered by: chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
Duration: 3 hours
Actions:

Definition (rev db79390766c74b5c78e905f2f711f95842d49a9d)

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

Incoming triggers

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

Incoming properties

{
  "version": "86.0.4240.22"
}

Incoming tags

  • parent_buildername:publish_tarball
  • user_agent:recipe

Debug log (UTC)

[20:11:30.172] New invocation is queued and will start shortly
[20:11:30.172] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[20:11:31.423] Starting the invocation (attempt 1)
[20:11:31.464] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:11:31.464] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:11:31.465] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9035669498286577248",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4240.22\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"0b062cf7-ad94-4086-bf4c-1a7e699916f9\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4240.22\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9035669498286577248",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[20:11:31.953] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1599077491557233",
    "id": "8870239436171552160",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4240.22\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"0b062cf7-ad94-4086-bf4c-1a7e699916f9\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4240.22\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1599077491795658",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9035669498286577248",
      "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/8870239436171552160/+/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": "1599077491795803",
    "url": "https://ci.chromium.org/b/8870239436171552160",
    "utcnow_ts": "1599077491941895"
  }
}
[20:11:31.953] Task URL: https://ci.chromium.org/b/8870239436171552160
[20:11:31.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:2:0) after 1m0s
[20:12:00.916] Received PubSub notification, asking Buildbucket for the build status
[20:12:01.012] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:32.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:2:0)
[20:12:32.064] Timer tick, asking Buildbucket for the build status
[20:12:32.195] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:32.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:4:0) after 1m0s
[20:13:32.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:4:0)
[20:13:32.239] Timer tick, asking Buildbucket for the build status
[20:13:32.386] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:32.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:5:0) after 1m0s
[20:14:32.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:5:0)
[20:14:32.476] Timer tick, asking Buildbucket for the build status
[20:14:32.639] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:32.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:6:0) after 1m0s
[20:15:32.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:6:0)
[20:15:32.645] Timer tick, asking Buildbucket for the build status
[20:15:32.735] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:32.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:7:0) after 1m0s
[20:16:32.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:7:0)
[20:16:32.862] Timer tick, asking Buildbucket for the build status
[20:16:32.946] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:32.946] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:8:0) after 1m0s
[20:17:33.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:8:0)
[20:17:33.088] Timer tick, asking Buildbucket for the build status
[20:17:33.265] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:33.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:9:0) after 1m0s
[20:18:33.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:9:0)
[20:18:33.373] Timer tick, asking Buildbucket for the build status
[20:18:33.512] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:33.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:10:0) after 1m0s
[20:19:34.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:10:0)
[20:19:34.086] Timer tick, asking Buildbucket for the build status
[20:19:34.158] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:34.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:11:0) after 1m0s
[20:20:34.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:11:0)
[20:20:34.669] Timer tick, asking Buildbucket for the build status
[20:20:34.782] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:34.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:12:0) after 1m0s
[20:21:35.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:12:0)
[20:21:35.479] Timer tick, asking Buildbucket for the build status
[20:21:35.638] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:35.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:13:0) after 1m0s
[20:22:35.781] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:13:0)
[20:22:35.781] Timer tick, asking Buildbucket for the build status
[20:22:35.840] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:35.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:14:0) after 1m0s
[20:23:35.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:14:0)
[20:23:35.898] Timer tick, asking Buildbucket for the build status
[20:23:36.041] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:36.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:15:0) after 1m0s
[20:24:36.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:15:0)
[20:24:36.397] Timer tick, asking Buildbucket for the build status
[20:24:36.469] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:36.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:16:0) after 1m0s
[20:25:37.136] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:16:0)
[20:25:37.136] Timer tick, asking Buildbucket for the build status
[20:25:37.203] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:37.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:17:0) after 1m0s
[20:26:37.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:17:0)
[20:26:37.292] Timer tick, asking Buildbucket for the build status
[20:26:37.501] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:37.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:18:0) after 1m0s
[20:27:37.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:18:0)
[20:27:37.625] Timer tick, asking Buildbucket for the build status
[20:27:37.708] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:37.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:19:0) after 1m0s
[20:28:37.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:19:0)
[20:28:37.864] Timer tick, asking Buildbucket for the build status
[20:28:38.097] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:38.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:20:0) after 1m0s
[20:29:38.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:20:0)
[20:29:38.221] Timer tick, asking Buildbucket for the build status
[20:29:38.591] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:38.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:21:0) after 1m0s
[20:30:38.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:21:0)
[20:30:38.693] Timer tick, asking Buildbucket for the build status
[20:30:42.786] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:42.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:22:0) after 1m0s
[20:31:42.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:22:0)
[20:31:42.971] Timer tick, asking Buildbucket for the build status
[20:31:45.642] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:45.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:23:0) after 1m0s
[20:32:45.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:23:0)
[20:32:45.667] Timer tick, asking Buildbucket for the build status
[20:32:45.865] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:45.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:24:0) after 1m0s
[20:33:46.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:24:0)
[20:33:46.131] Timer tick, asking Buildbucket for the build status
[20:33:46.217] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:46.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:25:0) after 1m0s
[20:34:46.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:25:0)
[20:34:46.409] Timer tick, asking Buildbucket for the build status
[20:34:46.519] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:46.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:26:0) after 1m0s
[20:35:46.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:26:0)
[20:35:46.618] Timer tick, asking Buildbucket for the build status
[20:35:47.821] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:47.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:27:0) after 1m0s
[20:36:47.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:27:0)
[20:36:47.987] Timer tick, asking Buildbucket for the build status
[20:36:48.161] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:48.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:28:0) after 1m0s
[20:37:48.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:28:0)
[20:37:48.243] Timer tick, asking Buildbucket for the build status
[20:37:48.341] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:48.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:29:0) after 1m0s
[20:38:48.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:29:0)
[20:38:48.502] Timer tick, asking Buildbucket for the build status
[20:38:48.736] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:48.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:30:0) after 1m0s
[20:39:48.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:30:0)
[20:39:48.840] Timer tick, asking Buildbucket for the build status
[20:39:48.905] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:48.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:31:0) after 1m0s
[20:40:49.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:31:0)
[20:40:49.353] Timer tick, asking Buildbucket for the build status
[20:40:49.462] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:49.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:32:0) after 1m0s
[20:41:49.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:32:0)
[20:41:49.742] Timer tick, asking Buildbucket for the build status
[20:41:50.184] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:50.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:33:0) after 1m0s
[20:42:50.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:33:0)
[20:42:50.375] Timer tick, asking Buildbucket for the build status
[20:42:51.500] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:51.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:34:0) after 1m0s
[20:43:51.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:34:0)
[20:43:51.507] Timer tick, asking Buildbucket for the build status
[20:43:51.563] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:51.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:35:0) after 1m0s
[20:44:51.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:35:0)
[20:44:51.591] Timer tick, asking Buildbucket for the build status
[20:44:51.776] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:51.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:36:0) after 1m0s
[20:45:51.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:36:0)
[20:45:51.802] Timer tick, asking Buildbucket for the build status
[20:45:51.871] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:51.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:37:0) after 1m0s
[20:46:52.090] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:37:0)
[20:46:52.092] Timer tick, asking Buildbucket for the build status
[20:46:52.254] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:52.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:38:0) after 1m0s
[20:47:52.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:38:0)
[20:47:52.483] Timer tick, asking Buildbucket for the build status
[20:47:52.872] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:52.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:39:0) after 1m0s
[20:48:53.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:39:0)
[20:48:53.194] Timer tick, asking Buildbucket for the build status
[20:48:53.819] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:53.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:40:0) after 1m0s
[20:49:54.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:40:0)
[20:49:54.203] Timer tick, asking Buildbucket for the build status
[20:49:54.299] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:54.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:41:0) after 1m0s
[20:50:54.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:41:0)
[20:50:54.619] Timer tick, asking Buildbucket for the build status
[20:50:54.854] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:54.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:42:0) after 1m0s
[20:51:55.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:42:0)
[20:51:55.287] Timer tick, asking Buildbucket for the build status
[20:51:55.881] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:55.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:43:0) after 1m0s
[20:52:56.280] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:43:0)
[20:52:56.280] Timer tick, asking Buildbucket for the build status
[20:52:56.633] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:56.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:44:0) after 1m0s
[20:53:56.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:44:0)
[20:53:56.783] Timer tick, asking Buildbucket for the build status
[20:53:57.589] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:57.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:45:0) after 1m0s
[20:54:57.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:45:0)
[20:54:57.841] Timer tick, asking Buildbucket for the build status
[20:54:57.994] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:57.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:46:0) after 1m0s
[20:55:58.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:46:0)
[20:55:58.247] Timer tick, asking Buildbucket for the build status
[20:55:58.451] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:58.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:47:0) after 1m0s
[20:56:58.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:47:0)
[20:56:58.465] Timer tick, asking Buildbucket for the build status
[20:56:58.602] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:58.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:48:0) after 1m0s
[20:57:58.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:48:0)
[20:57:58.808] Timer tick, asking Buildbucket for the build status
[20:57:58.935] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:58.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:49:0) after 1m0s
[20:58:59.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:49:0)
[20:58:59.077] Timer tick, asking Buildbucket for the build status
[20:58:59.223] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:59.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:50:0) after 1m0s
[20:59:59.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:50:0)
[20:59:59.265] Timer tick, asking Buildbucket for the build status
[20:59:59.355] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:59.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:51:0) after 1m0s
[21:00:59.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:51:0)
[21:00:59.569] Timer tick, asking Buildbucket for the build status
[21:00:59.721] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:59.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:52:0) after 1m0s
[21:01:59.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:52:0)
[21:01:59.811] Timer tick, asking Buildbucket for the build status
[21:01:59.971] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:59.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:53:0) after 1m0s
[21:03:00.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:53:0)
[21:03:00.085] Timer tick, asking Buildbucket for the build status
[21:03:00.238] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:00.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:54:0) after 1m0s
[21:04:00.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:54:0)
[21:04:00.265] Timer tick, asking Buildbucket for the build status
[21:04:00.371] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:00.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:55:0) after 1m0s
[21:05:00.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:55:0)
[21:05:00.610] Timer tick, asking Buildbucket for the build status
[21:05:00.738] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:00.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:56:0) after 1m0s
[21:06:01.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:56:0)
[21:06:01.574] Timer tick, asking Buildbucket for the build status
[21:06:01.818] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:01.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:57:0) after 1m0s
[21:07:01.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:57:0)
[21:07:01.866] Timer tick, asking Buildbucket for the build status
[21:07:02.105] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:02.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:58:0) after 1m0s
[21:08:02.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:58:0)
[21:08:02.191] Timer tick, asking Buildbucket for the build status
[21:08:02.281] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:02.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:59:0) after 1m0s
[21:09:02.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:59:0)
[21:09:02.376] Timer tick, asking Buildbucket for the build status
[21:09:02.449] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:02.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:60:0) after 1m0s
[21:10:02.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:60:0)
[21:10:02.691] Timer tick, asking Buildbucket for the build status
[21:10:02.954] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:02.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:61:0) after 1m0s
[21:11:03.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:61:0)
[21:11:03.125] Timer tick, asking Buildbucket for the build status
[21:11:03.504] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:03.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:62:0) after 1m0s
[21:12:03.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:62:0)
[21:12:03.653] Timer tick, asking Buildbucket for the build status
[21:12:03.886] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:03.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:63:0) after 1m0s
[21:13:03.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:63:0)
[21:13:03.892] Timer tick, asking Buildbucket for the build status
[21:13:03.973] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:03.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:64:0) after 1m0s
[21:14:04.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:64:0)
[21:14:04.023] Timer tick, asking Buildbucket for the build status
[21:14:04.110] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:04.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:65:0) after 1m0s
[21:15:04.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:65:0)
[21:15:04.175] Timer tick, asking Buildbucket for the build status
[21:15:04.511] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:04.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:66:0) after 1m0s
[21:16:04.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:66:0)
[21:16:04.589] Timer tick, asking Buildbucket for the build status
[21:16:04.901] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:04.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:67:0) after 1m0s
[21:17:05.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:67:0)
[21:17:05.018] Timer tick, asking Buildbucket for the build status
[21:17:05.299] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:05.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:68:0) after 1m0s
[21:18:05.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:68:0)
[21:18:05.355] Timer tick, asking Buildbucket for the build status
[21:18:05.537] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:05.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:69:0) after 1m0s
[21:19:05.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:69:0)
[21:19:05.596] Timer tick, asking Buildbucket for the build status
[21:19:05.734] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:05.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:70:0) after 1m0s
[21:20:05.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:70:0)
[21:20:05.801] Timer tick, asking Buildbucket for the build status
[21:20:05.866] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:05.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:71:0) after 1m0s
[21:21:05.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:71:0)
[21:21:05.956] Timer tick, asking Buildbucket for the build status
[21:21:06.175] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:06.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:72:0) after 1m0s
[21:22:06.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:72:0)
[21:22:06.412] Timer tick, asking Buildbucket for the build status
[21:22:06.645] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:06.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:73:0) after 1m0s
[21:23:06.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:73:0)
[21:23:06.687] Timer tick, asking Buildbucket for the build status
[21:23:06.882] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:06.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:74:0) after 1m0s
[21:24:06.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:74:0)
[21:24:06.910] Timer tick, asking Buildbucket for the build status
[21:24:07.560] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:07.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:75:0) after 1m0s
[21:25:07.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:75:0)
[21:25:07.621] Timer tick, asking Buildbucket for the build status
[21:25:07.793] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:07.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:76:0) after 1m0s
[21:26:08.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:76:0)
[21:26:08.028] Timer tick, asking Buildbucket for the build status
[21:26:08.417] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:08.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:77:0) after 1m0s
[21:27:08.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:77:0)
[21:27:08.484] Timer tick, asking Buildbucket for the build status
[21:27:08.723] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:08.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:78:0) after 1m0s
[21:28:08.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:78:0)
[21:28:08.773] Timer tick, asking Buildbucket for the build status
[21:28:08.863] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:08.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:79:0) after 1m0s
[21:29:08.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:79:0)
[21:29:08.986] Timer tick, asking Buildbucket for the build status
[21:29:09.094] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:09.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:80:0) after 1m0s
[21:30:09.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:80:0)
[21:30:09.104] Timer tick, asking Buildbucket for the build status
[21:30:09.440] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:09.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:81:0) after 1m0s
[21:31:09.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:81:0)
[21:31:09.497] Timer tick, asking Buildbucket for the build status
[21:31:09.564] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:09.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:82:0) after 1m0s
[21:32:09.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:82:0)
[21:32:09.664] Timer tick, asking Buildbucket for the build status
[21:32:10.300] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:10.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:83:0) after 1m0s
[21:33:10.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:83:0)
[21:33:10.317] Timer tick, asking Buildbucket for the build status
[21:33:10.444] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:10.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:84:0) after 1m0s
[21:34:10.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:84:0)
[21:34:10.486] Timer tick, asking Buildbucket for the build status
[21:34:10.586] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:10.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:85:0) after 1m0s
[21:35:10.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:85:0)
[21:35:10.681] Timer tick, asking Buildbucket for the build status
[21:35:10.885] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:10.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:86:0) after 1m0s
[21:36:11.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:86:0)
[21:36:11.177] Timer tick, asking Buildbucket for the build status
[21:36:11.264] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:11.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:87:0) after 1m0s
[21:37:11.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:87:0)
[21:37:11.576] Timer tick, asking Buildbucket for the build status
[21:37:11.754] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:11.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:88:0) after 1m0s
[21:38:11.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:88:0)
[21:38:11.889] Timer tick, asking Buildbucket for the build status
[21:38:11.959] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:11.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:89:0) after 1m0s
[21:39:11.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:89:0)
[21:39:11.996] Timer tick, asking Buildbucket for the build status
[21:39:12.076] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:12.076] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:90:0) after 1m0s
[21:40:12.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:90:0)
[21:40:12.124] Timer tick, asking Buildbucket for the build status
[21:40:12.394] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:12.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:91:0) after 1m0s
[21:41:12.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:91:0)
[21:41:12.453] Timer tick, asking Buildbucket for the build status
[21:41:12.551] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:12.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:92:0) after 1m0s
[21:42:12.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:92:0)
[21:42:12.586] Timer tick, asking Buildbucket for the build status
[21:42:12.690] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:12.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:93:0) after 1m0s
[21:43:12.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:93:0)
[21:43:12.865] Timer tick, asking Buildbucket for the build status
[21:43:13.051] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:13.051] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:94:0) after 1m0s
[21:44:13.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:94:0)
[21:44:13.107] Timer tick, asking Buildbucket for the build status
[21:44:13.177] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:13.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:95:0) after 1m0s
[21:45:13.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:95:0)
[21:45:13.258] Timer tick, asking Buildbucket for the build status
[21:45:13.326] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:13.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:96:0) after 1m0s
[21:46:13.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:96:0)
[21:46:13.387] Timer tick, asking Buildbucket for the build status
[21:46:13.593] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:13.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:97:0) after 1m0s
[21:47:13.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:97:0)
[21:47:13.652] Timer tick, asking Buildbucket for the build status
[21:47:14.302] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:14.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:98:0) after 1m0s
[21:48:14.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:98:0)
[21:48:14.377] Timer tick, asking Buildbucket for the build status
[21:48:14.539] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:14.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:99:0) after 1m0s
[21:49:14.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:99:0)
[21:49:14.588] Timer tick, asking Buildbucket for the build status
[21:49:14.878] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:14.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:100:0) after 1m0s
[21:50:15.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:100:0)
[21:50:15.154] Timer tick, asking Buildbucket for the build status
[21:50:15.440] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:15.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:101:0) after 1m0s
[21:51:15.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:101:0)
[21:51:15.551] Timer tick, asking Buildbucket for the build status
[21:51:15.795] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:15.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:102:0) after 1m0s
[21:52:15.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:102:0)
[21:52:15.873] Timer tick, asking Buildbucket for the build status
[21:52:16.239] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:16.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:103:0) after 1m0s
[21:53:16.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:103:0)
[21:53:16.323] Timer tick, asking Buildbucket for the build status
[21:53:16.426] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:16.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:104:0) after 1m0s
[21:54:16.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:104:0)
[21:54:16.637] Timer tick, asking Buildbucket for the build status
[21:54:16.988] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:16.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:105:0) after 1m0s
[21:55:17.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:105:0)
[21:55:17.123] Timer tick, asking Buildbucket for the build status
[21:55:17.210] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:17.210] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:106:0) after 1m0s
[21:56:17.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:106:0)
[21:56:17.203] Timer tick, asking Buildbucket for the build status
[21:56:17.284] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:17.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:107:0) after 1m0s
[21:57:17.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:107:0)
[21:57:17.316] Timer tick, asking Buildbucket for the build status
[21:57:17.872] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:17.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:108:0) after 1m0s
[21:58:18.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:108:0)
[21:58:18.141] Timer tick, asking Buildbucket for the build status
[21:58:18.243] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:18.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:109:0) after 1m0s
[21:59:18.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:109:0)
[21:59:18.520] Timer tick, asking Buildbucket for the build status
[21:59:18.634] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:18.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:110:0) after 1m0s
[22:00:18.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:110:0)
[22:00:18.970] Timer tick, asking Buildbucket for the build status
[22:00:19.156] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:19.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:111:0) after 1m0s
[22:01:19.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:111:0)
[22:01:19.221] Timer tick, asking Buildbucket for the build status
[22:01:19.437] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:19.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:112:0) after 1m0s
[22:02:19.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:112:0)
[22:02:19.544] Timer tick, asking Buildbucket for the build status
[22:02:19.812] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:19.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:113:0) after 1m0s
[22:03:19.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:113:0)
[22:03:19.836] Timer tick, asking Buildbucket for the build status
[22:03:20.005] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:20.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:114:0) after 1m0s
[22:04:20.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:114:0)
[22:04:20.083] Timer tick, asking Buildbucket for the build status
[22:04:20.202] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:20.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:115:0) after 1m0s
[22:05:20.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:115:0)
[22:05:20.548] Timer tick, asking Buildbucket for the build status
[22:05:21.106] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:21.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:116:0) after 1m0s
[22:06:21.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:116:0)
[22:06:21.179] Timer tick, asking Buildbucket for the build status
[22:06:21.333] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:21.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:117:0) after 1m0s
[22:07:21.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:117:0)
[22:07:21.446] Timer tick, asking Buildbucket for the build status
[22:07:21.702] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:21.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:118:0) after 1m0s
[22:08:21.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:118:0)
[22:08:21.797] Timer tick, asking Buildbucket for the build status
[22:08:22.185] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:22.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:119:0) after 1m0s
[22:09:22.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:119:0)
[22:09:22.236] Timer tick, asking Buildbucket for the build status
[22:09:22.482] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:22.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:120:0) after 1m0s
[22:10:22.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:120:0)
[22:10:22.548] Timer tick, asking Buildbucket for the build status
[22:10:22.623] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:22.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:121:0) after 1m0s
[22:11:22.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:121:0)
[22:11:22.702] Timer tick, asking Buildbucket for the build status
[22:11:23.354] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:23.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:122:0) after 1m0s
[22:12:23.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:122:0)
[22:12:23.392] Timer tick, asking Buildbucket for the build status
[22:12:23.549] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:23.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:123:0) after 1m0s
[22:13:23.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:123:0)
[22:13:23.599] Timer tick, asking Buildbucket for the build status
[22:13:23.751] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:23.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:124:0) after 1m0s
[22:14:23.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:124:0)
[22:14:23.992] Timer tick, asking Buildbucket for the build status
[22:14:24.209] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:24.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:125:0) after 1m0s
[22:15:24.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:125:0)
[22:15:24.288] Timer tick, asking Buildbucket for the build status
[22:15:24.420] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:24.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:126:0) after 1m0s
[22:16:24.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:126:0)
[22:16:24.520] Timer tick, asking Buildbucket for the build status
[22:16:24.755] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:24.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:127:0) after 1m0s
[22:17:24.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:127:0)
[22:17:24.912] Timer tick, asking Buildbucket for the build status
[22:17:25.063] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:25.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:128:0) after 1m0s
[22:18:25.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:128:0)
[22:18:25.097] Timer tick, asking Buildbucket for the build status
[22:18:25.660] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:25.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:129:0) after 1m0s
[22:19:25.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:129:0)
[22:19:25.747] Timer tick, asking Buildbucket for the build status
[22:19:25.813] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:25.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:130:0) after 1m0s
[22:20:25.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:130:0)
[22:20:25.876] Timer tick, asking Buildbucket for the build status
[22:20:25.929] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:25.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:131:0) after 1m0s
[22:21:25.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:131:0)
[22:21:25.976] Timer tick, asking Buildbucket for the build status
[22:21:26.079] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:26.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:132:0) after 1m0s
[22:22:26.170] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:132:0)
[22:22:26.170] Timer tick, asking Buildbucket for the build status
[22:22:26.532] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:26.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:133:0) after 1m0s
[22:23:26.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:133:0)
[22:23:26.854] Timer tick, asking Buildbucket for the build status
[22:23:27.284] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:27.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:134:0) after 1m0s
[22:24:27.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:134:0)
[22:24:27.449] Timer tick, asking Buildbucket for the build status
[22:24:27.558] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:27.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:135:0) after 1m0s
[22:25:27.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:135:0)
[22:25:27.635] Timer tick, asking Buildbucket for the build status
[22:25:28.022] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:28.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:136:0) after 1m0s
[22:26:28.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:136:0)
[22:26:28.054] Timer tick, asking Buildbucket for the build status
[22:26:28.394] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:28.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:137:0) after 1m0s
[22:27:28.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:137:0)
[22:27:28.457] Timer tick, asking Buildbucket for the build status
[22:27:28.898] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:28.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:138:0) after 1m0s
[22:28:28.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:138:0)
[22:28:28.922] Timer tick, asking Buildbucket for the build status
[22:28:29.015] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:29.015] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:139:0) after 1m0s
[22:29:29.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:139:0)
[22:29:29.048] Timer tick, asking Buildbucket for the build status
[22:29:29.144] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:29.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:140:0) after 1m0s
[22:30:29.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:140:0)
[22:30:29.179] Timer tick, asking Buildbucket for the build status
[22:30:29.480] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:29.480] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:141:0) after 1m0s
[22:31:29.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:141:0)
[22:31:29.639] Timer tick, asking Buildbucket for the build status
[22:31:30.044] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:30.047] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:142:0) after 1m0s
[22:32:30.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:142:0)
[22:32:30.104] Timer tick, asking Buildbucket for the build status
[22:32:30.523] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:30.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:143:0) after 1m0s
[22:33:30.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:143:0)
[22:33:30.596] Timer tick, asking Buildbucket for the build status
[22:33:30.724] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:30.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:144:0) after 1m0s
[22:34:30.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:144:0)
[22:34:30.846] Timer tick, asking Buildbucket for the build status
[22:34:30.985] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:30.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:145:0) after 1m0s
[22:35:31.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:145:0)
[22:35:31.221] Timer tick, asking Buildbucket for the build status
[22:35:31.335] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:31.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:146:0) after 1m0s
[22:36:31.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:146:0)
[22:36:31.358] Timer tick, asking Buildbucket for the build status
[22:36:31.516] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:31.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:147:0) after 1m0s
[22:37:31.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:147:0)
[22:37:31.549] Timer tick, asking Buildbucket for the build status
[22:37:31.723] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:31.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:148:0) after 1m0s
[22:38:31.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:148:0)
[22:38:31.802] Timer tick, asking Buildbucket for the build status
[22:38:31.938] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:31.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:149:0) after 1m0s
[22:39:31.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:149:0)
[22:39:31.989] Timer tick, asking Buildbucket for the build status
[22:39:32.087] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:32.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:150:0) after 1m0s
[22:40:32.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:150:0)
[22:40:32.346] Timer tick, asking Buildbucket for the build status
[22:40:32.472] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:32.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:151:0) after 1m0s
[22:41:32.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:151:0)
[22:41:32.603] Timer tick, asking Buildbucket for the build status
[22:41:32.709] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:32.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:152:0) after 1m0s
[22:42:33.130] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:152:0)
[22:42:33.130] Timer tick, asking Buildbucket for the build status
[22:42:33.269] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:33.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:153:0) after 1m0s
[22:43:33.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:153:0)
[22:43:33.490] Timer tick, asking Buildbucket for the build status
[22:43:34.292] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:34.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:154:0) after 1m0s
[22:44:34.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:154:0)
[22:44:34.726] Timer tick, asking Buildbucket for the build status
[22:44:34.825] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:34.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:155:0) after 1m0s
[22:45:34.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:155:0)
[22:45:34.870] Timer tick, asking Buildbucket for the build status
[22:45:34.940] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:34.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:156:0) after 1m0s
[22:46:35.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:156:0)
[22:46:35.221] Timer tick, asking Buildbucket for the build status
[22:46:35.326] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:35.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:157:0) after 1m0s
[22:47:35.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:157:0)
[22:47:35.538] Timer tick, asking Buildbucket for the build status
[22:47:36.056] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:36.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:158:0) after 1m0s
[22:48:36.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:158:0)
[22:48:36.085] Timer tick, asking Buildbucket for the build status
[22:48:36.248] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:36.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:159:0) after 1m0s
[22:49:36.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:159:0)
[22:49:36.290] Timer tick, asking Buildbucket for the build status
[22:49:37.412] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:37.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:160:0) after 1m0s
[22:50:37.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:160:0)
[22:50:37.769] Timer tick, asking Buildbucket for the build status
[22:50:37.890] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:37.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:161:0) after 1m0s
[22:51:38.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:161:0)
[22:51:38.004] Timer tick, asking Buildbucket for the build status
[22:51:38.082] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:38.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:162:0) after 1m0s
[22:52:38.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:162:0)
[22:52:38.178] Timer tick, asking Buildbucket for the build status
[22:52:39.357] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:39.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:163:0) after 1m0s
[22:53:39.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:163:0)
[22:53:39.437] Timer tick, asking Buildbucket for the build status
[22:53:39.570] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:39.570] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:164:0) after 1m0s
[22:54:39.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:164:0)
[22:54:39.661] Timer tick, asking Buildbucket for the build status
[22:54:39.821] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:39.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:165:0) after 1m0s
[22:55:40.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:165:0)
[22:55:40.115] Timer tick, asking Buildbucket for the build status
[22:55:40.494] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:40.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:166:0) after 1m0s
[22:56:40.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:166:0)
[22:56:40.568] Timer tick, asking Buildbucket for the build status
[22:56:40.658] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:40.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:167:0) after 1m0s
[22:57:40.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:167:0)
[22:57:40.690] Timer tick, asking Buildbucket for the build status
[22:57:40.800] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:40.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:168:0) after 1m0s
[22:58:40.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:168:0)
[22:58:40.830] Timer tick, asking Buildbucket for the build status
[22:58:41.104] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:41.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:169:0) after 1m0s
[22:59:41.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:169:0)
[22:59:41.436] Timer tick, asking Buildbucket for the build status
[22:59:42.171] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:42.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:170:0) after 1m0s
[23:00:42.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:170:0)
[23:00:42.365] Timer tick, asking Buildbucket for the build status
[23:00:42.587] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:42.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:171:0) after 1m0s
[23:01:42.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:171:0)
[23:01:42.722] Timer tick, asking Buildbucket for the build status
[23:01:42.892] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:42.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:172:0) after 1m0s
[23:02:42.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:172:0)
[23:02:42.986] Timer tick, asking Buildbucket for the build status
[23:02:43.145] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:43.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:173:0) after 1m0s
[23:03:43.269] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:173:0)
[23:03:43.269] Timer tick, asking Buildbucket for the build status
[23:03:43.554] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:43.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:174:0) after 1m0s
[23:04:43.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:174:0)
[23:04:43.606] Timer tick, asking Buildbucket for the build status
[23:04:43.679] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:43.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:175:0) after 1m0s
[23:05:43.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:175:0)
[23:05:43.702] Timer tick, asking Buildbucket for the build status
[23:05:43.829] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:43.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:176:0) after 1m0s
[23:06:43.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:176:0)
[23:06:43.893] Timer tick, asking Buildbucket for the build status
[23:06:43.996] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:43.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:177:0) after 1m0s
[23:07:44.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:177:0)
[23:07:44.166] Timer tick, asking Buildbucket for the build status
[23:07:44.725] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:44.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:178:0) after 1m0s
[23:08:44.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:178:0)
[23:08:44.773] Timer tick, asking Buildbucket for the build status
[23:08:44.876] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:44.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:179:0) after 1m0s
[23:09:44.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:179:0)
[23:09:44.946] Timer tick, asking Buildbucket for the build status
[23:09:45.074] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:45.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:180:0) after 1m0s
[23:10:45.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:180:0)
[23:10:45.116] Timer tick, asking Buildbucket for the build status
[23:10:45.234] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:45.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:181:0) after 1m0s
[23:11:45.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:181:0)
[23:11:45.331] Timer tick, asking Buildbucket for the build status
[23:11:45.954] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:45.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:182:0) after 1m0s
[23:12:46.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:182:0)
[23:12:46.034] Timer tick, asking Buildbucket for the build status
[23:12:46.221] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:46.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:183:0) after 1m0s
[23:13:46.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:183:0)
[23:13:46.572] Timer tick, asking Buildbucket for the build status
[23:13:46.700] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:46.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:184:0) after 1m0s
[23:14:46.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:184:0)
[23:14:46.758] Timer tick, asking Buildbucket for the build status
[23:14:46.877] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:46.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:185:0) after 1m0s
[23:15:46.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:185:0)
[23:15:46.894] Timer tick, asking Buildbucket for the build status
[23:15:47.147] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:47.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:186:0) after 1m0s
[23:16:47.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:186:0)
[23:16:47.277] Timer tick, asking Buildbucket for the build status
[23:16:47.446] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:47.446] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:187:0) after 1m0s
[23:17:47.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:187:0)
[23:17:47.512] Timer tick, asking Buildbucket for the build status
[23:17:47.573] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:47.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:188:0) after 1m0s
[23:18:47.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:188:0)
[23:18:47.718] Timer tick, asking Buildbucket for the build status
[23:18:47.795] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:47.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:189:0) after 1m0s
[23:19:47.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:189:0)
[23:19:47.835] Timer tick, asking Buildbucket for the build status
[23:19:47.905] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:47.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:190:0) after 1m0s
[23:20:48.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:190:0)
[23:20:48.034] Timer tick, asking Buildbucket for the build status
[23:20:48.116] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:48.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:191:0) after 1m0s
[23:21:48.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:191:0)
[23:21:48.232] Timer tick, asking Buildbucket for the build status
[23:21:48.328] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:48.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:192:0) after 1m0s
[23:22:48.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:192:0)
[23:22:48.376] Timer tick, asking Buildbucket for the build status
[23:22:48.464] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:48.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:193:0) after 1m0s
[23:23:48.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:193:0)
[23:23:48.636] Timer tick, asking Buildbucket for the build status
[23:23:48.831] Build 8870239436171552160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:48.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035669498286577248:194:0) after 1m0s
[23:24:01.633] Received PubSub notification, asking Buildbucket for the build status
[23:24:01.783] Build 8870239436171552160: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:24:01.783] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1599089040885216",
    "created_by": "project:infra",
    "created_ts": "1599077491557233",
    "id": "8870239436171552160",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4240.22\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"0b062cf7-ad94-4086-bf4c-1a7e699916f9\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4240.22\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-07ed\"], \"image\": [\"chrome-xenial-20081700-d9392568d25\"], \"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\": [\"5507-6e8d655\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1599077519645191",
    "status": "COMPLETED",
    "status_changed_ts": "1599089041326846",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9035669498286577248",
      "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/8870239436171552160/+/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:4e6943adb8e7fe10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1599089041351409",
    "url": "https://ci.chromium.org/b/8870239436171552160",
    "utcnow_ts": "1599089041749017"
  }
}
[23:24:01.783] Invocation finished in 3h12m31.627088007s with status SUCCEEDED