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

Definition (rev ef1333c7bf2cf95d15a0ce92acf83d24bcd6c5ac)

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

Incoming triggers

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

Incoming properties

{
  "version": "85.0.4164.3"
}

Incoming tags

  • parent_buildername:publish_tarball
  • user_agent:recipe

Debug log (UTC)

[10:09:42.456] New invocation is queued and will start shortly
[10:09:42.456] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[10:09:43.879] Starting the invocation (attempt 1)
[10:09:43.917] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:09:43.917] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:09:43.917] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9043770489982609872",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4164.3\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"d1893140-8747-430d-bd2e-31d524dcd420\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4164.3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9043770489982609872",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[10:09:44.369] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "created_by": "project:infra",
    "created_ts": "1591351784053134",
    "id": "8878340427642850128",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4164.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"d1893140-8747-430d-bd2e-31d524dcd420\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4164.3\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1591351784239270",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9043770489982609872",
      "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/8878340427642850128/+/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": "1591351784239496",
    "url": "https://ci.chromium.org/b/8878340427642850128",
    "utcnow_ts": "1591351784361999"
  }
}
[10:09:44.369] Task URL: https://ci.chromium.org/b/8878340427642850128
[10:09:44.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:2:0) after 1m0s
[10:10:44.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:2:0)
[10:10:44.381] Timer tick, asking Buildbucket for the build status
[10:10:44.508] Build 8878340427642850128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:10:44.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:3:0) after 1m0s
[10:10:52.693] Received PubSub notification, asking Buildbucket for the build status
[10:10:52.873] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:44.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:3:0)
[10:11:44.564] Timer tick, asking Buildbucket for the build status
[10:11:44.858] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:44.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:5:0) after 1m0s
[10:12:44.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:5:0)
[10:12:44.951] Timer tick, asking Buildbucket for the build status
[10:12:45.083] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:45.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:6:0) after 1m0s
[10:13:45.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:6:0)
[10:13:45.164] Timer tick, asking Buildbucket for the build status
[10:13:45.823] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:45.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:7:0) after 1m0s
[10:14:46.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:7:0)
[10:14:46.124] Timer tick, asking Buildbucket for the build status
[10:14:46.301] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:46.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:8:0) after 1m0s
[10:15:46.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:8:0)
[10:15:46.612] Timer tick, asking Buildbucket for the build status
[10:15:46.794] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:46.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:9:0) after 1m0s
[10:16:46.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:9:0)
[10:16:46.984] Timer tick, asking Buildbucket for the build status
[10:16:47.126] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:47.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:10:0) after 1m0s
[10:17:47.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:10:0)
[10:17:47.197] Timer tick, asking Buildbucket for the build status
[10:17:47.384] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:47.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:11:0) after 1m0s
[10:18:47.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:11:0)
[10:18:47.428] Timer tick, asking Buildbucket for the build status
[10:18:47.986] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:47.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:12:0) after 1m0s
[10:19:48.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:12:0)
[10:19:48.466] Timer tick, asking Buildbucket for the build status
[10:19:48.591] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:48.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:13:0) after 1m0s
[10:20:48.630] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:13:0)
[10:20:48.630] Timer tick, asking Buildbucket for the build status
[10:20:48.750] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:48.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:14:0) after 1m0s
[10:21:48.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:14:0)
[10:21:48.771] Timer tick, asking Buildbucket for the build status
[10:21:48.895] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:48.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:15:0) after 1m0s
[10:22:48.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:15:0)
[10:22:48.966] Timer tick, asking Buildbucket for the build status
[10:22:49.425] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:49.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:16:0) after 1m0s
[10:23:49.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:16:0)
[10:23:49.455] Timer tick, asking Buildbucket for the build status
[10:23:49.695] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:49.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:17:0) after 1m0s
[10:24:49.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:17:0)
[10:24:49.766] Timer tick, asking Buildbucket for the build status
[10:24:50.609] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:50.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:18:0) after 1m0s
[10:25:50.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:18:0)
[10:25:50.611] Timer tick, asking Buildbucket for the build status
[10:25:50.745] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:50.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:19:0) after 1m0s
[10:26:50.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:19:0)
[10:26:50.764] Timer tick, asking Buildbucket for the build status
[10:26:51.134] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:51.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:20:0) after 1m0s
[10:27:51.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:20:0)
[10:27:51.166] Timer tick, asking Buildbucket for the build status
[10:27:51.347] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:51.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:21:0) after 1m0s
[10:28:51.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:21:0)
[10:28:51.416] Timer tick, asking Buildbucket for the build status
[10:28:51.686] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:51.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:22:0) after 1m0s
[10:29:51.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:22:0)
[10:29:51.759] Timer tick, asking Buildbucket for the build status
[10:29:51.910] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:51.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:23:0) after 1m0s
[10:30:51.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:23:0)
[10:30:51.885] Timer tick, asking Buildbucket for the build status
[10:30:52.196] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:52.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:24:0) after 1m0s
[10:31:52.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:24:0)
[10:31:52.273] Timer tick, asking Buildbucket for the build status
[10:31:52.770] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:52.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:25:0) after 1m0s
[10:32:52.792] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:25:0)
[10:32:52.792] Timer tick, asking Buildbucket for the build status
[10:32:53.158] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:53.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:26:0) after 1m0s
[10:33:53.180] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:26:0)
[10:33:53.180] Timer tick, asking Buildbucket for the build status
[10:33:53.752] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:53.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:27:0) after 1m0s
[10:34:53.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:27:0)
[10:34:53.771] Timer tick, asking Buildbucket for the build status
[10:34:53.898] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:53.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:28:0) after 1m0s
[10:35:53.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:28:0)
[10:35:53.871] Timer tick, asking Buildbucket for the build status
[10:35:54.011] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:54.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:29:0) after 1m0s
[10:36:54.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:29:0)
[10:36:54.076] Timer tick, asking Buildbucket for the build status
[10:36:54.266] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:54.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:30:0) after 1m0s
[10:37:54.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:30:0)
[10:37:54.296] Timer tick, asking Buildbucket for the build status
[10:37:54.430] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:54.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:31:0) after 1m0s
[10:38:54.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:31:0)
[10:38:54.521] Timer tick, asking Buildbucket for the build status
[10:38:54.702] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:54.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:32:0) after 1m0s
[10:39:54.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:32:0)
[10:39:54.725] Timer tick, asking Buildbucket for the build status
[10:39:55.140] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:55.140] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:33:0) after 1m0s
[10:40:55.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:33:0)
[10:40:55.166] Timer tick, asking Buildbucket for the build status
[10:40:55.737] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:55.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:34:0) after 1m0s
[10:41:55.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:34:0)
[10:41:55.753] Timer tick, asking Buildbucket for the build status
[10:41:56.126] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:56.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:35:0) after 1m0s
[10:42:56.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:35:0)
[10:42:56.294] Timer tick, asking Buildbucket for the build status
[10:42:56.548] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:56.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:36:0) after 1m0s
[10:43:56.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:36:0)
[10:43:56.693] Timer tick, asking Buildbucket for the build status
[10:43:57.117] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:57.117] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:37:0) after 1m0s
[10:44:57.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:37:0)
[10:44:57.254] Timer tick, asking Buildbucket for the build status
[10:44:57.489] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:57.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:38:0) after 1m0s
[10:45:57.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:38:0)
[10:45:57.611] Timer tick, asking Buildbucket for the build status
[10:45:57.913] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:57.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:39:0) after 1m0s
[10:46:58.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:39:0)
[10:46:58.042] Timer tick, asking Buildbucket for the build status
[10:46:58.243] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:58.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:40:0) after 1m0s
[10:47:58.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:40:0)
[10:47:58.324] Timer tick, asking Buildbucket for the build status
[10:47:58.450] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:58.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:41:0) after 1m0s
[10:48:58.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:41:0)
[10:48:58.525] Timer tick, asking Buildbucket for the build status
[10:48:58.648] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:58.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:42:0) after 1m0s
[10:49:58.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:42:0)
[10:49:58.689] Timer tick, asking Buildbucket for the build status
[10:49:58.850] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:58.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:43:0) after 1m0s
[10:50:58.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:43:0)
[10:50:58.969] Timer tick, asking Buildbucket for the build status
[10:50:59.103] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:59.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:44:0) after 1m0s
[10:51:59.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:44:0)
[10:51:59.200] Timer tick, asking Buildbucket for the build status
[10:51:59.474] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:59.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:45:0) after 1m0s
[10:52:59.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:45:0)
[10:52:59.561] Timer tick, asking Buildbucket for the build status
[10:52:59.841] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:59.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:46:0) after 1m0s
[10:53:59.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:46:0)
[10:53:59.821] Timer tick, asking Buildbucket for the build status
[10:54:00.121] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:00.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:47:0) after 1m0s
[10:55:00.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:47:0)
[10:55:00.198] Timer tick, asking Buildbucket for the build status
[10:55:00.411] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:00.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:48:0) after 1m0s
[10:56:00.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:48:0)
[10:56:00.617] Timer tick, asking Buildbucket for the build status
[10:56:00.831] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:00.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:49:0) after 1m0s
[10:57:01.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:49:0)
[10:57:01.101] Timer tick, asking Buildbucket for the build status
[10:57:01.427] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:01.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:50:0) after 1m0s
[10:58:03.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:50:0)
[10:58:03.403] Timer tick, asking Buildbucket for the build status
[10:58:03.863] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:03.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:51:0) after 1m0s
[10:59:03.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:51:0)
[10:59:03.943] Timer tick, asking Buildbucket for the build status
[10:59:04.083] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:04.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:52:0) after 1m0s
[11:00:04.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:52:0)
[11:00:04.588] Timer tick, asking Buildbucket for the build status
[11:00:04.765] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:04.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:53:0) after 1m0s
[11:01:05.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:53:0)
[11:01:05.049] Timer tick, asking Buildbucket for the build status
[11:01:05.256] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:05.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:54:0) after 1m0s
[11:02:05.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:54:0)
[11:02:05.510] Timer tick, asking Buildbucket for the build status
[11:02:05.660] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:05.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:55:0) after 1m0s
[11:03:05.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:55:0)
[11:03:05.788] Timer tick, asking Buildbucket for the build status
[11:03:05.922] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:05.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:56:0) after 1m0s
[11:04:05.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:56:0)
[11:04:05.953] Timer tick, asking Buildbucket for the build status
[11:04:06.383] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:06.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:57:0) after 1m0s
[11:05:06.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:57:0)
[11:05:06.475] Timer tick, asking Buildbucket for the build status
[11:05:06.626] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:06.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:58:0) after 1m0s
[11:06:06.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:58:0)
[11:06:06.837] Timer tick, asking Buildbucket for the build status
[11:06:06.967] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:06.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:59:0) after 1m0s
[11:07:07.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:59:0)
[11:07:07.031] Timer tick, asking Buildbucket for the build status
[11:07:07.171] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:07.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:60:0) after 1m0s
[11:08:07.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:60:0)
[11:08:07.218] Timer tick, asking Buildbucket for the build status
[11:08:08.037] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:08.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:61:0) after 1m0s
[11:09:08.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:61:0)
[11:09:08.097] Timer tick, asking Buildbucket for the build status
[11:09:08.247] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:08.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:62:0) after 1m0s
[11:10:08.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:62:0)
[11:10:08.284] Timer tick, asking Buildbucket for the build status
[11:10:08.802] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:08.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:63:0) after 1m0s
[11:11:08.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:63:0)
[11:11:08.940] Timer tick, asking Buildbucket for the build status
[11:11:09.465] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:09.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:64:0) after 1m0s
[11:12:09.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:64:0)
[11:12:09.517] Timer tick, asking Buildbucket for the build status
[11:12:09.719] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:09.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:65:0) after 1m0s
[11:13:09.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:65:0)
[11:13:09.750] Timer tick, asking Buildbucket for the build status
[11:13:09.862] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:09.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:66:0) after 1m0s
[11:14:09.888] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:66:0)
[11:14:09.888] Timer tick, asking Buildbucket for the build status
[11:14:10.203] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:10.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:67:0) after 1m0s
[11:15:10.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:67:0)
[11:15:10.315] Timer tick, asking Buildbucket for the build status
[11:15:12.142] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:12.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:68:0) after 1m0s
[11:16:12.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:68:0)
[11:16:12.442] Timer tick, asking Buildbucket for the build status
[11:16:12.865] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:12.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:69:0) after 1m0s
[11:17:13.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:69:0)
[11:17:13.058] Timer tick, asking Buildbucket for the build status
[11:17:13.276] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:13.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:70:0) after 1m0s
[11:18:13.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:70:0)
[11:18:13.291] Timer tick, asking Buildbucket for the build status
[11:18:13.592] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:13.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:71:0) after 1m0s
[11:19:14.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:71:0)
[11:19:14.068] Timer tick, asking Buildbucket for the build status
[11:19:14.233] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:14.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:72:0) after 1m0s
[11:20:15.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:72:0)
[11:20:15.157] Timer tick, asking Buildbucket for the build status
[11:20:15.620] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:15.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:73:0) after 1m0s
[11:21:15.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:73:0)
[11:21:15.735] Timer tick, asking Buildbucket for the build status
[11:21:15.867] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:15.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:74:0) after 1m0s
[11:22:15.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:74:0)
[11:22:15.974] Timer tick, asking Buildbucket for the build status
[11:22:16.579] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:16.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:75:0) after 1m0s
[11:23:16.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:75:0)
[11:23:16.651] Timer tick, asking Buildbucket for the build status
[11:23:17.057] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:17.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:76:0) after 1m0s
[11:24:17.269] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:76:0)
[11:24:17.269] Timer tick, asking Buildbucket for the build status
[11:24:17.498] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:17.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:77:0) after 1m0s
[11:25:17.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:77:0)
[11:25:17.523] Timer tick, asking Buildbucket for the build status
[11:25:17.657] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:17.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:78:0) after 1m0s
[11:26:17.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:78:0)
[11:26:17.777] Timer tick, asking Buildbucket for the build status
[11:26:18.166] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:18.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:79:0) after 1m0s
[11:27:18.207] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:79:0)
[11:27:18.207] Timer tick, asking Buildbucket for the build status
[11:27:18.604] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:18.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:80:0) after 1m0s
[11:28:18.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:80:0)
[11:28:18.634] Timer tick, asking Buildbucket for the build status
[11:28:18.972] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:18.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:81:0) after 1m0s
[11:29:19.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:81:0)
[11:29:19.103] Timer tick, asking Buildbucket for the build status
[11:29:19.245] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:19.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:82:0) after 1m0s
[11:30:19.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:82:0)
[11:30:19.267] Timer tick, asking Buildbucket for the build status
[11:30:19.421] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:19.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:83:0) after 1m0s
[11:31:19.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:83:0)
[11:31:19.506] Timer tick, asking Buildbucket for the build status
[11:31:19.692] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:19.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:84:0) after 1m0s
[11:32:19.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:84:0)
[11:32:19.803] Timer tick, asking Buildbucket for the build status
[11:32:20.291] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:20.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:85:0) after 1m0s
[11:33:20.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:85:0)
[11:33:20.284] Timer tick, asking Buildbucket for the build status
[11:33:20.476] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:20.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:86:0) after 1m0s
[11:34:20.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:86:0)
[11:34:20.499] Timer tick, asking Buildbucket for the build status
[11:34:20.790] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:20.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:87:0) after 1m0s
[11:35:20.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:87:0)
[11:35:20.821] Timer tick, asking Buildbucket for the build status
[11:35:21.252] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:21.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:88:0) after 1m0s
[11:36:21.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:88:0)
[11:36:21.259] Timer tick, asking Buildbucket for the build status
[11:36:21.522] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:21.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:89:0) after 1m0s
[11:37:21.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:89:0)
[11:37:21.587] Timer tick, asking Buildbucket for the build status
[11:37:21.751] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:21.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:90:0) after 1m0s
[11:38:21.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:90:0)
[11:38:21.857] Timer tick, asking Buildbucket for the build status
[11:38:22.476] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:22.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:91:0) after 1m0s
[11:39:22.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:91:0)
[11:39:22.528] Timer tick, asking Buildbucket for the build status
[11:39:22.960] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:22.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:92:0) after 1m0s
[11:40:23.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:92:0)
[11:40:23.066] Timer tick, asking Buildbucket for the build status
[11:40:23.265] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:23.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:93:0) after 1m0s
[11:41:23.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:93:0)
[11:41:23.403] Timer tick, asking Buildbucket for the build status
[11:41:23.519] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:23.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:94:0) after 1m0s
[11:42:23.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:94:0)
[11:42:23.916] Timer tick, asking Buildbucket for the build status
[11:42:24.072] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:24.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:95:0) after 1m0s
[11:43:24.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:95:0)
[11:43:24.379] Timer tick, asking Buildbucket for the build status
[11:43:24.481] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:24.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:96:0) after 1m0s
[11:44:27.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:96:0)
[11:44:27.728] Timer tick, asking Buildbucket for the build status
[11:44:27.885] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:27.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:97:0) after 1m0s
[11:45:28.030] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:97:0)
[11:45:28.030] Timer tick, asking Buildbucket for the build status
[11:45:28.168] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:28.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:98:0) after 1m0s
[11:46:28.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:98:0)
[11:46:28.210] Timer tick, asking Buildbucket for the build status
[11:46:28.387] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:28.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:99:0) after 1m0s
[11:47:28.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:99:0)
[11:47:28.403] Timer tick, asking Buildbucket for the build status
[11:47:28.542] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:28.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:100:0) after 1m0s
[11:48:28.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:100:0)
[11:48:28.580] Timer tick, asking Buildbucket for the build status
[11:48:28.782] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:28.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:101:0) after 1m0s
[11:49:28.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:101:0)
[11:49:28.870] Timer tick, asking Buildbucket for the build status
[11:49:29.091] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:29.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:102:0) after 1m0s
[11:50:29.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:102:0)
[11:50:29.117] Timer tick, asking Buildbucket for the build status
[11:50:29.410] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:29.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:103:0) after 1m0s
[11:51:29.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:103:0)
[11:51:29.481] Timer tick, asking Buildbucket for the build status
[11:51:29.901] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:29.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:104:0) after 1m0s
[11:52:29.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:104:0)
[11:52:29.993] Timer tick, asking Buildbucket for the build status
[11:52:30.087] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:30.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:105:0) after 1m0s
[11:53:30.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:105:0)
[11:53:30.152] Timer tick, asking Buildbucket for the build status
[11:53:30.472] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:30.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:106:0) after 1m0s
[11:54:30.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:106:0)
[11:54:30.511] Timer tick, asking Buildbucket for the build status
[11:54:30.793] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:30.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:107:0) after 1m0s
[11:55:30.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:107:0)
[11:55:30.833] Timer tick, asking Buildbucket for the build status
[11:55:32.015] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:32.015] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:108:0) after 1m0s
[11:56:32.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:108:0)
[11:56:32.106] Timer tick, asking Buildbucket for the build status
[11:56:32.286] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:32.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:109:0) after 1m0s
[11:57:32.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:109:0)
[11:57:32.519] Timer tick, asking Buildbucket for the build status
[11:57:32.787] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:32.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:110:0) after 1m0s
[11:58:32.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:110:0)
[11:58:32.895] Timer tick, asking Buildbucket for the build status
[11:58:33.020] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:33.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:111:0) after 1m0s
[11:59:33.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:111:0)
[11:59:33.088] Timer tick, asking Buildbucket for the build status
[11:59:33.267] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:33.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:112:0) after 1m0s
[12:00:33.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:112:0)
[12:00:33.356] Timer tick, asking Buildbucket for the build status
[12:00:34.246] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:34.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:113:0) after 1m0s
[12:01:34.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:113:0)
[12:01:34.282] Timer tick, asking Buildbucket for the build status
[12:01:34.442] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:34.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:114:0) after 1m0s
[12:02:34.524] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:114:0)
[12:02:34.524] Timer tick, asking Buildbucket for the build status
[12:02:34.711] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:34.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:115:0) after 1m0s
[12:03:34.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:115:0)
[12:03:34.760] Timer tick, asking Buildbucket for the build status
[12:03:35.432] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:35.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:116:0) after 1m0s
[12:04:35.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:116:0)
[12:04:35.579] Timer tick, asking Buildbucket for the build status
[12:04:35.785] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:35.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:117:0) after 1m0s
[12:05:35.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:117:0)
[12:05:35.833] Timer tick, asking Buildbucket for the build status
[12:05:36.119] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:36.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:118:0) after 1m0s
[12:06:36.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:118:0)
[12:06:36.232] Timer tick, asking Buildbucket for the build status
[12:06:36.471] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:36.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:119:0) after 1m0s
[12:07:36.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:119:0)
[12:07:36.562] Timer tick, asking Buildbucket for the build status
[12:07:36.682] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:36.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:120:0) after 1m0s
[12:08:36.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:120:0)
[12:08:36.714] Timer tick, asking Buildbucket for the build status
[12:08:37.186] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:37.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:121:0) after 1m0s
[12:09:37.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:121:0)
[12:09:37.241] Timer tick, asking Buildbucket for the build status
[12:09:37.559] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:37.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:122:0) after 1m0s
[12:10:37.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:122:0)
[12:10:37.692] Timer tick, asking Buildbucket for the build status
[12:10:37.953] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:37.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:123:0) after 1m0s
[12:11:38.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:123:0)
[12:11:38.036] Timer tick, asking Buildbucket for the build status
[12:11:38.364] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:38.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:124:0) after 1m0s
[12:12:38.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:124:0)
[12:12:38.543] Timer tick, asking Buildbucket for the build status
[12:12:38.662] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:38.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:125:0) after 1m0s
[12:13:38.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:125:0)
[12:13:38.744] Timer tick, asking Buildbucket for the build status
[12:13:39.371] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:39.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:126:0) after 1m0s
[12:14:39.456] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:126:0)
[12:14:39.456] Timer tick, asking Buildbucket for the build status
[12:14:39.632] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:39.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:127:0) after 1m0s
[12:15:39.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:127:0)
[12:15:39.697] Timer tick, asking Buildbucket for the build status
[12:15:39.856] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:39.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:128:0) after 1m0s
[12:16:39.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:128:0)
[12:16:39.892] Timer tick, asking Buildbucket for the build status
[12:16:40.026] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:40.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:129:0) after 1m0s
[12:17:40.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:129:0)
[12:17:40.093] Timer tick, asking Buildbucket for the build status
[12:17:40.281] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:40.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:130:0) after 1m0s
[12:18:40.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:130:0)
[12:18:40.452] Timer tick, asking Buildbucket for the build status
[12:18:40.977] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:40.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:131:0) after 1m0s
[12:19:41.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:131:0)
[12:19:41.091] Timer tick, asking Buildbucket for the build status
[12:19:42.049] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:42.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:132:0) after 1m0s
[12:20:42.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:132:0)
[12:20:42.077] Timer tick, asking Buildbucket for the build status
[12:20:42.579] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:42.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:133:0) after 1m0s
[12:21:42.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:133:0)
[12:21:42.686] Timer tick, asking Buildbucket for the build status
[12:21:42.819] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:42.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:134:0) after 1m0s
[12:22:42.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:134:0)
[12:22:42.966] Timer tick, asking Buildbucket for the build status
[12:22:43.167] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:43.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:135:0) after 1m0s
[12:23:43.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:135:0)
[12:23:43.379] Timer tick, asking Buildbucket for the build status
[12:23:44.620] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:44.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:136:0) after 1m0s
[12:24:44.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:136:0)
[12:24:44.701] Timer tick, asking Buildbucket for the build status
[12:24:44.855] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:44.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:137:0) after 1m0s
[12:25:44.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:137:0)
[12:25:44.880] Timer tick, asking Buildbucket for the build status
[12:25:45.549] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:45.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:138:0) after 1m0s
[12:26:45.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:138:0)
[12:26:45.619] Timer tick, asking Buildbucket for the build status
[12:26:46.114] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:46.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:139:0) after 1m0s
[12:27:46.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:139:0)
[12:27:46.137] Timer tick, asking Buildbucket for the build status
[12:27:46.319] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:46.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:140:0) after 1m0s
[12:28:46.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:140:0)
[12:28:46.370] Timer tick, asking Buildbucket for the build status
[12:28:46.686] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:46.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:141:0) after 1m0s
[12:29:46.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:141:0)
[12:29:46.862] Timer tick, asking Buildbucket for the build status
[12:29:47.157] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:47.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:142:0) after 1m0s
[12:30:47.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:142:0)
[12:30:47.247] Timer tick, asking Buildbucket for the build status
[12:30:47.377] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:47.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:143:0) after 1m0s
[12:31:47.643] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:143:0)
[12:31:47.643] Timer tick, asking Buildbucket for the build status
[12:31:47.931] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:47.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:144:0) after 1m0s
[12:32:48.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:144:0)
[12:32:48.000] Timer tick, asking Buildbucket for the build status
[12:32:49.163] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:49.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:145:0) after 1m0s
[12:33:49.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:145:0)
[12:33:49.442] Timer tick, asking Buildbucket for the build status
[12:33:49.602] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:49.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:146:0) after 1m0s
[12:34:49.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:146:0)
[12:34:49.637] Timer tick, asking Buildbucket for the build status
[12:34:49.777] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:49.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:147:0) after 1m0s
[12:35:49.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:147:0)
[12:35:49.878] Timer tick, asking Buildbucket for the build status
[12:35:50.336] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:50.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:148:0) after 1m0s
[12:36:50.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:148:0)
[12:36:50.412] Timer tick, asking Buildbucket for the build status
[12:36:50.674] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:50.674] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:149:0) after 1m0s
[12:37:50.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:149:0)
[12:37:50.746] Timer tick, asking Buildbucket for the build status
[12:37:50.893] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:50.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:150:0) after 1m0s
[12:38:50.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:150:0)
[12:38:50.989] Timer tick, asking Buildbucket for the build status
[12:38:51.185] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:51.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:151:0) after 1m0s
[12:39:51.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:151:0)
[12:39:51.508] Timer tick, asking Buildbucket for the build status
[12:39:51.616] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:51.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:152:0) after 1m0s
[12:40:51.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:152:0)
[12:40:51.778] Timer tick, asking Buildbucket for the build status
[12:40:51.898] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:51.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:153:0) after 1m0s
[12:41:52.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:153:0)
[12:41:52.112] Timer tick, asking Buildbucket for the build status
[12:41:52.311] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:52.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:154:0) after 1m0s
[12:42:52.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:154:0)
[12:42:52.483] Timer tick, asking Buildbucket for the build status
[12:42:52.867] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:52.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:155:0) after 1m0s
[12:43:52.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:155:0)
[12:43:52.876] Timer tick, asking Buildbucket for the build status
[12:43:53.168] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:53.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:156:0) after 1m0s
[12:44:53.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:156:0)
[12:44:53.348] Timer tick, asking Buildbucket for the build status
[12:44:53.538] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:53.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:157:0) after 1m0s
[12:45:53.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:157:0)
[12:45:53.629] Timer tick, asking Buildbucket for the build status
[12:45:53.968] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:53.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:158:0) after 1m0s
[12:46:53.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:158:0)
[12:46:53.970] Timer tick, asking Buildbucket for the build status
[12:46:54.884] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:54.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:159:0) after 1m0s
[12:47:54.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:159:0)
[12:47:54.921] Timer tick, asking Buildbucket for the build status
[12:47:55.120] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:55.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:160:0) after 1m0s
[12:48:55.222] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:160:0)
[12:48:55.222] Timer tick, asking Buildbucket for the build status
[12:48:55.362] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:55.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:161:0) after 1m0s
[12:49:55.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:161:0)
[12:49:55.516] Timer tick, asking Buildbucket for the build status
[12:49:55.672] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:55.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:162:0) after 1m0s
[12:50:55.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:162:0)
[12:50:55.745] Timer tick, asking Buildbucket for the build status
[12:50:55.915] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:55.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:163:0) after 1m0s
[12:51:56.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:163:0)
[12:51:56.146] Timer tick, asking Buildbucket for the build status
[12:51:56.470] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:56.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:164:0) after 1m0s
[12:52:56.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:164:0)
[12:52:56.520] Timer tick, asking Buildbucket for the build status
[12:52:56.734] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:56.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:165:0) after 1m0s
[12:53:56.792] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:165:0)
[12:53:56.792] Timer tick, asking Buildbucket for the build status
[12:53:56.937] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:56.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:166:0) after 1m0s
[12:54:57.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:166:0)
[12:54:57.203] Timer tick, asking Buildbucket for the build status
[12:54:57.339] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:57.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:167:0) after 1m0s
[12:55:57.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:167:0)
[12:55:57.480] Timer tick, asking Buildbucket for the build status
[12:55:57.626] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:57.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:168:0) after 1m0s
[12:56:57.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:168:0)
[12:56:57.659] Timer tick, asking Buildbucket for the build status
[12:56:57.790] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:57.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:169:0) after 1m0s
[12:57:57.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:169:0)
[12:57:57.818] Timer tick, asking Buildbucket for the build status
[12:57:57.999] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:57.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:170:0) after 1m0s
[12:58:58.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:170:0)
[12:58:58.038] Timer tick, asking Buildbucket for the build status
[12:58:58.229] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:58.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:171:0) after 1m0s
[12:59:58.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:171:0)
[12:59:58.346] Timer tick, asking Buildbucket for the build status
[12:59:58.764] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:58.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:172:0) after 1m0s
[13:00:58.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:172:0)
[13:00:58.863] Timer tick, asking Buildbucket for the build status
[13:00:59.110] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:59.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:173:0) after 1m0s
[13:01:59.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:173:0)
[13:01:59.152] Timer tick, asking Buildbucket for the build status
[13:01:59.278] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:59.278] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:174:0) after 1m0s
[13:02:59.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:174:0)
[13:02:59.580] Timer tick, asking Buildbucket for the build status
[13:03:00.186] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:00.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:175:0) after 1m0s
[13:04:00.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:175:0)
[13:04:00.252] Timer tick, asking Buildbucket for the build status
[13:04:00.615] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:00.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:176:0) after 1m0s
[13:05:00.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:176:0)
[13:05:00.699] Timer tick, asking Buildbucket for the build status
[13:05:00.947] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:00.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:177:0) after 1m0s
[13:06:01.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:177:0)
[13:06:01.053] Timer tick, asking Buildbucket for the build status
[13:06:01.634] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:01.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:178:0) after 1m0s
[13:07:01.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:178:0)
[13:07:01.750] Timer tick, asking Buildbucket for the build status
[13:07:02.025] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:02.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:179:0) after 1m0s
[13:08:02.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:179:0)
[13:08:02.186] Timer tick, asking Buildbucket for the build status
[13:08:02.478] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:02.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:180:0) after 1m0s
[13:09:02.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:180:0)
[13:09:02.565] Timer tick, asking Buildbucket for the build status
[13:09:02.974] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:02.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:181:0) after 1m0s
[13:10:04.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:181:0)
[13:10:04.637] Timer tick, asking Buildbucket for the build status
[13:10:04.765] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:04.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:182:0) after 1m0s
[13:11:04.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:182:0)
[13:11:04.865] Timer tick, asking Buildbucket for the build status
[13:11:05.416] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:05.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:183:0) after 1m0s
[13:12:05.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:183:0)
[13:12:05.634] Timer tick, asking Buildbucket for the build status
[13:12:05.950] Build 8878340427642850128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:05.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043770489982609872:184:0) after 1m0s
[13:13:00.394] Received PubSub notification, asking Buildbucket for the build status
[13:13:00.501] Build 8878340427642850128: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:13:00.501] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "completed_ts": "1591362779033767",
    "created_by": "project:infra",
    "created_ts": "1591351784053134",
    "id": "8878340427642850128",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4164.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"d1893140-8747-430d-bd2e-31d524dcd420\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4164.3\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-dd41\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5168-d212e19\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1591351851745541",
    "status": "COMPLETED",
    "status_changed_ts": "1591362779533520",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9043770489982609872",
      "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/8878340427642850128/+/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:4c9cc6be2a25bb10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1591362779633344",
    "url": "https://ci.chromium.org/b/8878340427642850128",
    "utcnow_ts": "1591362780494070"
  }
}
[13:13:00.501] Invocation finished in 3h3m18.063554263s with status SUCCEEDED