LUCI Scheduler :: infra :: Build From Tarball

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

Incoming tags

parent_buildername:publish_tarball
user_agent:recipe

Debug log (UTC)

[19:56:37.142] New invocation is queued and will start shortly
[19:56:37.142] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[19:56:38.475] Starting the invocation (attempt 1)
[19:56:38.521] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:56:38.521] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:56:38.521] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9044639534375263712",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"84.0.4147.21\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"95545e09-de61-4e14-8e85-8fcdb1a35ee5\",\"title\":\"publish_tarball/0\"}]},\"version\":\"84.0.4147.21\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9044639534375263712",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[19:56:41.198] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1590522999191190",
    "id": "8879209471558640592",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4147.21\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"95545e09-de61-4e14-8e85-8fcdb1a35ee5\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4147.21\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1590523000485855",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9044639534375263712",
      "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/8879209471558640592/+/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": "1590523000486108",
    "url": "https://ci.chromium.org/b/8879209471558640592",
    "utcnow_ts": "1590523001150054"
  }
}
[19:56:41.198] Task URL: https://ci.chromium.org/b/8879209471558640592
[19:56:41.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:2:0) after 1m0s
[19:57:41.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:2:0)
[19:57:41.224] Timer tick, asking Buildbucket for the build status
[19:57:43.323] Build 8879209471558640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:43.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:3:0) after 1m0s
[19:58:43.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:3:0)
[19:58:43.430] Timer tick, asking Buildbucket for the build status
[19:58:43.938] Build 8879209471558640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:58:43.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:4:0) after 1m0s
[19:59:44.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:4:0)
[19:59:44.060] Timer tick, asking Buildbucket for the build status
[19:59:44.291] Build 8879209471558640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:44.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:5:0) after 1m0s
[20:00:44.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:5:0)
[20:00:44.334] Timer tick, asking Buildbucket for the build status
[20:00:44.659] Build 8879209471558640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:44.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:6:0) after 1m0s
[20:01:44.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:6:0)
[20:01:44.774] Timer tick, asking Buildbucket for the build status
[20:01:45.075] Build 8879209471558640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:45.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:7:0) after 1m0s
[20:02:45.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:7:0)
[20:02:45.095] Timer tick, asking Buildbucket for the build status
[20:02:45.439] Build 8879209471558640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:45.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:8:0) after 1m0s
[20:03:45.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:8:0)
[20:03:45.478] Timer tick, asking Buildbucket for the build status
[20:03:45.960] Build 8879209471558640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:45.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:9:0) after 1m0s
[20:04:46.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:9:0)
[20:04:46.022] Timer tick, asking Buildbucket for the build status
[20:04:47.403] Build 8879209471558640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:47.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:10:0) after 1m0s
[20:05:47.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:10:0)
[20:05:47.458] Timer tick, asking Buildbucket for the build status
[20:05:47.686] Build 8879209471558640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:47.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:11:0) after 1m0s
[20:06:47.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:11:0)
[20:06:47.714] Timer tick, asking Buildbucket for the build status
[20:06:47.905] Build 8879209471558640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:47.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:12:0) after 1m0s
[20:07:48.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:12:0)
[20:07:48.152] Timer tick, asking Buildbucket for the build status
[20:07:48.583] Build 8879209471558640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:48.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:13:0) after 1m0s
[20:08:48.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:13:0)
[20:08:48.793] Timer tick, asking Buildbucket for the build status
[20:08:49.135] Build 8879209471558640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:49.135] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:14:0) after 1m0s
[20:09:49.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:14:0)
[20:09:49.149] Timer tick, asking Buildbucket for the build status
[20:09:52.808] Build 8879209471558640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:52.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:15:0) after 1m0s
[20:10:27.510] Received PubSub notification, asking Buildbucket for the build status
[20:10:28.997] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:52.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:15:0)
[20:10:52.832] Timer tick, asking Buildbucket for the build status
[20:10:54.138] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:54.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:17:0) after 1m0s
[20:11:54.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:17:0)
[20:11:54.338] Timer tick, asking Buildbucket for the build status
[20:11:54.589] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:54.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:18:0) after 1m0s
[20:12:54.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:18:0)
[20:12:54.743] Timer tick, asking Buildbucket for the build status
[20:12:55.143] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:55.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:19:0) after 1m0s
[20:13:55.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:19:0)
[20:13:55.214] Timer tick, asking Buildbucket for the build status
[20:13:55.401] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:55.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:20:0) after 1m0s
[20:14:55.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:20:0)
[20:14:55.447] Timer tick, asking Buildbucket for the build status
[20:14:55.894] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:55.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:21:0) after 1m0s
[20:15:55.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:21:0)
[20:15:55.977] Timer tick, asking Buildbucket for the build status
[20:15:56.482] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:56.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:22:0) after 1m0s
[20:16:56.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:22:0)
[20:16:56.523] Timer tick, asking Buildbucket for the build status
[20:16:56.777] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:56.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:23:0) after 1m0s
[20:17:56.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:23:0)
[20:17:56.788] Timer tick, asking Buildbucket for the build status
[20:17:57.772] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:57.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:24:0) after 1m0s
[20:18:58.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:24:0)
[20:18:58.202] Timer tick, asking Buildbucket for the build status
[20:18:58.703] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:58.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:25:0) after 1m0s
[20:19:58.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:25:0)
[20:19:58.729] Timer tick, asking Buildbucket for the build status
[20:19:59.096] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:59.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:26:0) after 1m0s
[20:20:59.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:26:0)
[20:20:59.159] Timer tick, asking Buildbucket for the build status
[20:21:01.662] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:01.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:27:0) after 1m0s
[20:22:02.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:27:0)
[20:22:02.144] Timer tick, asking Buildbucket for the build status
[20:22:04.114] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:04.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:28:0) after 1m0s
[20:23:04.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:28:0)
[20:23:04.149] Timer tick, asking Buildbucket for the build status
[20:23:04.299] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:04.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:29:0) after 1m0s
[20:24:04.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:29:0)
[20:24:04.379] Timer tick, asking Buildbucket for the build status
[20:24:04.569] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:04.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:30:0) after 1m0s
[20:25:04.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:30:0)
[20:25:04.610] Timer tick, asking Buildbucket for the build status
[20:25:04.909] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:04.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:31:0) after 1m0s
[20:26:04.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:31:0)
[20:26:04.998] Timer tick, asking Buildbucket for the build status
[20:26:05.167] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:05.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:32:0) after 1m0s
[20:27:05.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:32:0)
[20:27:05.231] Timer tick, asking Buildbucket for the build status
[20:27:05.402] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:05.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:33:0) after 1m0s
[20:28:05.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:33:0)
[20:28:05.493] Timer tick, asking Buildbucket for the build status
[20:28:05.968] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:05.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:34:0) after 1m0s
[20:29:06.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:34:0)
[20:29:06.033] Timer tick, asking Buildbucket for the build status
[20:29:06.269] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:06.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:35:0) after 1m0s
[20:30:06.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:35:0)
[20:30:06.322] Timer tick, asking Buildbucket for the build status
[20:30:06.785] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:06.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:36:0) after 1m0s
[20:31:06.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:36:0)
[20:31:06.845] Timer tick, asking Buildbucket for the build status
[20:31:07.024] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:07.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:37:0) after 1m0s
[20:32:07.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:37:0)
[20:32:07.085] Timer tick, asking Buildbucket for the build status
[20:32:07.647] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:07.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:38:0) after 1m0s
[20:33:07.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:38:0)
[20:33:07.702] Timer tick, asking Buildbucket for the build status
[20:33:08.513] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:08.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:39:0) after 1m0s
[20:34:08.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:39:0)
[20:34:08.558] Timer tick, asking Buildbucket for the build status
[20:34:08.800] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:08.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:40:0) after 1m0s
[20:35:08.855] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:40:0)
[20:35:08.855] Timer tick, asking Buildbucket for the build status
[20:35:09.261] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:09.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:41:0) after 1m0s
[20:36:09.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:41:0)
[20:36:09.330] Timer tick, asking Buildbucket for the build status
[20:36:09.521] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:09.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:42:0) after 1m0s
[20:37:09.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:42:0)
[20:37:09.555] Timer tick, asking Buildbucket for the build status
[20:37:10.406] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:10.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:43:0) after 1m0s
[20:38:10.501] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:43:0)
[20:38:10.501] Timer tick, asking Buildbucket for the build status
[20:38:10.868] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:10.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:44:0) after 1m0s
[20:39:10.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:44:0)
[20:39:10.963] Timer tick, asking Buildbucket for the build status
[20:39:11.336] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:11.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:45:0) after 1m0s
[20:40:11.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:45:0)
[20:40:11.387] Timer tick, asking Buildbucket for the build status
[20:40:11.850] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:11.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:46:0) after 1m0s
[20:41:11.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:46:0)
[20:41:11.904] Timer tick, asking Buildbucket for the build status
[20:41:12.066] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:12.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:47:0) after 1m0s
[20:42:12.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:47:0)
[20:42:12.156] Timer tick, asking Buildbucket for the build status
[20:42:12.627] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:12.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:48:0) after 1m0s
[20:43:12.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:48:0)
[20:43:12.681] Timer tick, asking Buildbucket for the build status
[20:43:13.038] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:13.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:49:0) after 1m0s
[20:44:13.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:49:0)
[20:44:13.083] Timer tick, asking Buildbucket for the build status
[20:44:14.668] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:14.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:50:0) after 1m0s
[20:45:14.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:50:0)
[20:45:14.752] Timer tick, asking Buildbucket for the build status
[20:45:15.109] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:15.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:51:0) after 1m0s
[20:46:15.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:51:0)
[20:46:15.218] Timer tick, asking Buildbucket for the build status
[20:46:16.778] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:16.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:52:0) after 1m0s
[20:47:16.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:52:0)
[20:47:16.851] Timer tick, asking Buildbucket for the build status
[20:47:17.215] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:17.215] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:53:0) after 1m0s
[20:48:17.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:53:0)
[20:48:17.251] Timer tick, asking Buildbucket for the build status
[20:48:17.731] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:17.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:54:0) after 1m0s
[20:49:17.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:54:0)
[20:49:17.766] Timer tick, asking Buildbucket for the build status
[20:49:18.065] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:18.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:55:0) after 1m0s
[20:50:18.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:55:0)
[20:50:18.132] Timer tick, asking Buildbucket for the build status
[20:50:18.347] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:18.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:56:0) after 1m0s
[20:51:18.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:56:0)
[20:51:18.393] Timer tick, asking Buildbucket for the build status
[20:51:22.511] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:22.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:57:0) after 1m0s
[20:52:22.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:57:0)
[20:52:22.534] Timer tick, asking Buildbucket for the build status
[20:52:22.858] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:22.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:58:0) after 1m0s
[20:53:22.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:58:0)
[20:53:22.903] Timer tick, asking Buildbucket for the build status
[20:53:23.198] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:23.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:59:0) after 1m0s
[20:54:23.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:59:0)
[20:54:23.262] Timer tick, asking Buildbucket for the build status
[20:54:23.833] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:23.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:60:0) after 1m0s
[20:55:23.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:60:0)
[20:55:23.828] Timer tick, asking Buildbucket for the build status
[20:55:24.180] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:24.180] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:61:0) after 1m0s
[20:56:24.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:61:0)
[20:56:24.272] Timer tick, asking Buildbucket for the build status
[20:56:24.454] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:24.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:62:0) after 1m0s
[20:57:24.491] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:62:0)
[20:57:24.491] Timer tick, asking Buildbucket for the build status
[20:57:24.841] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:24.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:63:0) after 1m0s
[20:58:25.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:63:0)
[20:58:25.007] Timer tick, asking Buildbucket for the build status
[20:58:28.155] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:28.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:64:0) after 1m0s
[20:59:28.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:64:0)
[20:59:28.199] Timer tick, asking Buildbucket for the build status
[20:59:28.483] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:28.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:65:0) after 1m0s
[21:00:28.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:65:0)
[21:00:28.645] Timer tick, asking Buildbucket for the build status
[21:00:29.654] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:29.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:66:0) after 1m0s
[21:01:29.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:66:0)
[21:01:29.794] Timer tick, asking Buildbucket for the build status
[21:01:30.004] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:30.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:67:0) after 1m0s
[21:02:30.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:67:0)
[21:02:30.179] Timer tick, asking Buildbucket for the build status
[21:02:30.498] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:30.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:68:0) after 1m0s
[21:03:31.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:68:0)
[21:03:31.181] Timer tick, asking Buildbucket for the build status
[21:03:31.453] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:31.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:69:0) after 1m0s
[21:04:31.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:69:0)
[21:04:31.498] Timer tick, asking Buildbucket for the build status
[21:04:31.675] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:31.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:70:0) after 1m0s
[21:05:32.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:70:0)
[21:05:32.073] Timer tick, asking Buildbucket for the build status
[21:05:32.963] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:32.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:71:0) after 1m0s
[21:06:33.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:71:0)
[21:06:33.027] Timer tick, asking Buildbucket for the build status
[21:06:33.244] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:33.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:72:0) after 1m0s
[21:07:33.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:72:0)
[21:07:33.334] Timer tick, asking Buildbucket for the build status
[21:07:33.473] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:33.473] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:73:0) after 1m0s
[21:08:33.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:73:0)
[21:08:33.523] Timer tick, asking Buildbucket for the build status
[21:08:33.998] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:33.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:74:0) after 1m0s
[21:09:34.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:74:0)
[21:09:34.163] Timer tick, asking Buildbucket for the build status
[21:09:34.358] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:34.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:75:0) after 1m0s
[21:10:34.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:75:0)
[21:10:34.660] Timer tick, asking Buildbucket for the build status
[21:10:34.935] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:34.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:76:0) after 1m0s
[21:11:35.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:76:0)
[21:11:35.179] Timer tick, asking Buildbucket for the build status
[21:11:35.360] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:35.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:77:0) after 1m0s
[21:12:35.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:77:0)
[21:12:35.363] Timer tick, asking Buildbucket for the build status
[21:12:35.890] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:35.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:78:0) after 1m0s
[21:13:36.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:78:0)
[21:13:36.107] Timer tick, asking Buildbucket for the build status
[21:13:36.257] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:36.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:79:0) after 1m0s
[21:14:36.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:79:0)
[21:14:36.425] Timer tick, asking Buildbucket for the build status
[21:14:36.622] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:36.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:80:0) after 1m0s
[21:15:36.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:80:0)
[21:15:36.650] Timer tick, asking Buildbucket for the build status
[21:15:37.130] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:37.130] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:81:0) after 1m0s
[21:16:37.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:81:0)
[21:16:37.724] Timer tick, asking Buildbucket for the build status
[21:16:37.900] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:37.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:82:0) after 1m0s
[21:17:38.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:82:0)
[21:17:38.179] Timer tick, asking Buildbucket for the build status
[21:17:38.437] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:38.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:83:0) after 1m0s
[21:18:38.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:83:0)
[21:18:38.507] Timer tick, asking Buildbucket for the build status
[21:18:38.707] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:38.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:84:0) after 1m0s
[21:19:38.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:84:0)
[21:19:38.774] Timer tick, asking Buildbucket for the build status
[21:19:39.773] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:39.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:85:0) after 1m0s
[21:20:39.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:85:0)
[21:20:39.825] Timer tick, asking Buildbucket for the build status
[21:20:41.397] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:41.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:86:0) after 1m0s
[21:21:41.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:86:0)
[21:21:41.538] Timer tick, asking Buildbucket for the build status
[21:21:42.343] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:42.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:87:0) after 1m0s
[21:22:42.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:87:0)
[21:22:42.424] Timer tick, asking Buildbucket for the build status
[21:22:43.609] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:43.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:88:0) after 1m0s
[21:23:43.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:88:0)
[21:23:43.974] Timer tick, asking Buildbucket for the build status
[21:23:44.347] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:44.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:89:0) after 1m0s
[21:24:44.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:89:0)
[21:24:44.384] Timer tick, asking Buildbucket for the build status
[21:24:45.068] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:45.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:90:0) after 1m0s
[21:25:46.888] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:90:0)
[21:25:46.888] Timer tick, asking Buildbucket for the build status
[21:25:47.146] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:47.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:91:0) after 1m0s
[21:26:47.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:91:0)
[21:26:47.257] Timer tick, asking Buildbucket for the build status
[21:26:48.278] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:48.278] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:92:0) after 1m0s
[21:27:48.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:92:0)
[21:27:48.329] Timer tick, asking Buildbucket for the build status
[21:27:48.501] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:48.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:93:0) after 1m0s
[21:28:48.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:93:0)
[21:28:48.567] Timer tick, asking Buildbucket for the build status
[21:28:49.028] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:49.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:94:0) after 1m0s
[21:29:49.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:94:0)
[21:29:49.036] Timer tick, asking Buildbucket for the build status
[21:29:49.348] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:49.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:95:0) after 1m0s
[21:30:49.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:95:0)
[21:30:49.354] Timer tick, asking Buildbucket for the build status
[21:30:49.952] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:49.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:96:0) after 1m0s
[21:31:50.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:96:0)
[21:31:50.027] Timer tick, asking Buildbucket for the build status
[21:31:50.271] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:50.271] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:97:0) after 1m0s
[21:32:50.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:97:0)
[21:32:50.398] Timer tick, asking Buildbucket for the build status
[21:32:50.611] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:50.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:98:0) after 1m0s
[21:33:50.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:98:0)
[21:33:50.709] Timer tick, asking Buildbucket for the build status
[21:33:51.460] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:51.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:99:0) after 1m0s
[21:34:51.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:99:0)
[21:34:51.478] Timer tick, asking Buildbucket for the build status
[21:34:52.016] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:52.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:100:0) after 1m0s
[21:35:52.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:100:0)
[21:35:52.101] Timer tick, asking Buildbucket for the build status
[21:35:52.510] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:52.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:101:0) after 1m0s
[21:36:52.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:101:0)
[21:36:52.575] Timer tick, asking Buildbucket for the build status
[21:36:52.960] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:52.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:102:0) after 1m0s
[21:37:52.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:102:0)
[21:37:52.995] Timer tick, asking Buildbucket for the build status
[21:37:53.189] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:53.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:103:0) after 1m0s
[21:38:53.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:103:0)
[21:38:53.959] Timer tick, asking Buildbucket for the build status
[21:38:54.178] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:54.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:104:0) after 1m0s
[21:39:54.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:104:0)
[21:39:54.293] Timer tick, asking Buildbucket for the build status
[21:39:54.521] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:54.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:105:0) after 1m0s
[21:40:54.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:105:0)
[21:40:54.583] Timer tick, asking Buildbucket for the build status
[21:40:54.847] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:54.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:106:0) after 1m0s
[21:41:54.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:106:0)
[21:41:54.909] Timer tick, asking Buildbucket for the build status
[21:41:55.072] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:55.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:107:0) after 1m0s
[21:42:55.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:107:0)
[21:42:55.118] Timer tick, asking Buildbucket for the build status
[21:42:55.387] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:55.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:108:0) after 1m0s
[21:43:55.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:108:0)
[21:43:55.464] Timer tick, asking Buildbucket for the build status
[21:43:55.988] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:55.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:109:0) after 1m0s
[21:44:56.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:109:0)
[21:44:56.046] Timer tick, asking Buildbucket for the build status
[21:44:58.630] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:58.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:110:0) after 1m0s
[21:45:58.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:110:0)
[21:45:58.861] Timer tick, asking Buildbucket for the build status
[21:45:59.035] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:59.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:111:0) after 1m0s
[21:46:59.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:111:0)
[21:46:59.182] Timer tick, asking Buildbucket for the build status
[21:46:59.305] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:59.305] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:112:0) after 1m0s
[21:47:59.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:112:0)
[21:47:59.277] Timer tick, asking Buildbucket for the build status
[21:47:59.394] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:59.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:113:0) after 1m0s
[21:48:59.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:113:0)
[21:48:59.434] Timer tick, asking Buildbucket for the build status
[21:48:59.546] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:59.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:114:0) after 1m0s
[21:49:59.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:114:0)
[21:49:59.790] Timer tick, asking Buildbucket for the build status
[21:49:59.950] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:59.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:115:0) after 1m0s
[21:51:00.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:115:0)
[21:51:00.068] Timer tick, asking Buildbucket for the build status
[21:51:00.795] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:00.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:116:0) after 1m0s
[21:52:01.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:116:0)
[21:52:01.372] Timer tick, asking Buildbucket for the build status
[21:52:01.846] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:01.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:117:0) after 1m0s
[21:53:01.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:117:0)
[21:53:01.922] Timer tick, asking Buildbucket for the build status
[21:53:02.144] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:02.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:118:0) after 1m0s
[21:54:02.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:118:0)
[21:54:02.253] Timer tick, asking Buildbucket for the build status
[21:54:02.862] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:02.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:119:0) after 1m0s
[21:55:03.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:119:0)
[21:55:03.174] Timer tick, asking Buildbucket for the build status
[21:55:04.680] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:04.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:120:0) after 1m0s
[21:56:04.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:120:0)
[21:56:04.722] Timer tick, asking Buildbucket for the build status
[21:56:05.113] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:05.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:121:0) after 1m0s
[21:57:05.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:121:0)
[21:57:05.201] Timer tick, asking Buildbucket for the build status
[21:57:05.374] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:05.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:122:0) after 1m0s
[21:58:05.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:122:0)
[21:58:05.421] Timer tick, asking Buildbucket for the build status
[21:58:05.718] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:05.718] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:123:0) after 1m0s
[21:59:05.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:123:0)
[21:59:05.827] Timer tick, asking Buildbucket for the build status
[21:59:06.078] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:06.078] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:124:0) after 1m0s
[22:00:06.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:124:0)
[22:00:06.241] Timer tick, asking Buildbucket for the build status
[22:00:07.528] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:07.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:125:0) after 1m0s
[22:01:07.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:125:0)
[22:01:07.801] Timer tick, asking Buildbucket for the build status
[22:01:08.367] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:08.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:126:0) after 1m0s
[22:02:08.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:126:0)
[22:02:08.395] Timer tick, asking Buildbucket for the build status
[22:02:10.096] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:10.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:127:0) after 1m0s
[22:03:10.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:127:0)
[22:03:10.142] Timer tick, asking Buildbucket for the build status
[22:03:10.663] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:10.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:128:0) after 1m0s
[22:04:10.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:128:0)
[22:04:10.746] Timer tick, asking Buildbucket for the build status
[22:04:10.924] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:10.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:129:0) after 1m0s
[22:05:11.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:129:0)
[22:05:11.038] Timer tick, asking Buildbucket for the build status
[22:05:11.157] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:11.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:130:0) after 1m0s
[22:06:11.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:130:0)
[22:06:11.208] Timer tick, asking Buildbucket for the build status
[22:06:11.481] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:11.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:131:0) after 1m0s
[22:07:11.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:131:0)
[22:07:11.487] Timer tick, asking Buildbucket for the build status
[22:07:11.703] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:11.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:132:0) after 1m0s
[22:08:11.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:132:0)
[22:08:11.816] Timer tick, asking Buildbucket for the build status
[22:08:12.629] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:12.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:133:0) after 1m0s
[22:09:12.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:133:0)
[22:09:12.866] Timer tick, asking Buildbucket for the build status
[22:09:14.904] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:14.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:134:0) after 1m0s
[22:10:14.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:134:0)
[22:10:14.946] Timer tick, asking Buildbucket for the build status
[22:10:15.470] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:15.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:135:0) after 1m0s
[22:11:15.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:135:0)
[22:11:15.664] Timer tick, asking Buildbucket for the build status
[22:11:16.005] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:16.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:136:0) after 1m0s
[22:12:16.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:136:0)
[22:12:16.214] Timer tick, asking Buildbucket for the build status
[22:12:16.445] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:16.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:137:0) after 1m0s
[22:13:16.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:137:0)
[22:13:16.753] Timer tick, asking Buildbucket for the build status
[22:13:16.956] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:16.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:138:0) after 1m0s
[22:14:17.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:138:0)
[22:14:17.067] Timer tick, asking Buildbucket for the build status
[22:14:17.580] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:17.580] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:139:0) after 1m0s
[22:15:17.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:139:0)
[22:15:17.604] Timer tick, asking Buildbucket for the build status
[22:15:18.186] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:18.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:140:0) after 1m0s
[22:16:18.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:140:0)
[22:16:18.388] Timer tick, asking Buildbucket for the build status
[22:16:18.726] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:18.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:141:0) after 1m0s
[22:17:18.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:141:0)
[22:17:18.789] Timer tick, asking Buildbucket for the build status
[22:17:19.643] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:19.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:142:0) after 1m0s
[22:18:19.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:142:0)
[22:18:19.694] Timer tick, asking Buildbucket for the build status
[22:18:19.870] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:19.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:143:0) after 1m0s
[22:19:19.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:143:0)
[22:19:19.906] Timer tick, asking Buildbucket for the build status
[22:19:20.027] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:20.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:144:0) after 1m0s
[22:20:20.130] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:144:0)
[22:20:20.130] Timer tick, asking Buildbucket for the build status
[22:20:20.479] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:20.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:145:0) after 1m0s
[22:21:20.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:145:0)
[22:21:20.673] Timer tick, asking Buildbucket for the build status
[22:21:20.877] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:20.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:146:0) after 1m0s
[22:22:21.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:146:0)
[22:22:21.023] Timer tick, asking Buildbucket for the build status
[22:22:21.310] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:21.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:147:0) after 1m0s
[22:23:21.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:147:0)
[22:23:21.406] Timer tick, asking Buildbucket for the build status
[22:23:21.750] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:21.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:148:0) after 1m0s
[22:24:21.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:148:0)
[22:24:21.797] Timer tick, asking Buildbucket for the build status
[22:24:22.265] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:22.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:149:0) after 1m0s
[22:25:22.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:149:0)
[22:25:22.353] Timer tick, asking Buildbucket for the build status
[22:25:22.558] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:22.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:150:0) after 1m0s
[22:26:22.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:150:0)
[22:26:22.686] Timer tick, asking Buildbucket for the build status
[22:26:24.564] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:24.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:151:0) after 1m0s
[22:27:24.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:151:0)
[22:27:24.724] Timer tick, asking Buildbucket for the build status
[22:27:24.992] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:24.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:152:0) after 1m0s
[22:28:25.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:152:0)
[22:28:25.005] Timer tick, asking Buildbucket for the build status
[22:28:25.363] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:25.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:153:0) after 1m0s
[22:29:25.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:153:0)
[22:29:25.391] Timer tick, asking Buildbucket for the build status
[22:29:25.626] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:25.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:154:0) after 1m0s
[22:30:25.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:154:0)
[22:30:25.662] Timer tick, asking Buildbucket for the build status
[22:30:26.142] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:26.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:155:0) after 1m0s
[22:31:26.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:155:0)
[22:31:26.159] Timer tick, asking Buildbucket for the build status
[22:31:26.388] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:26.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:156:0) after 1m0s
[22:32:26.456] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:156:0)
[22:32:26.456] Timer tick, asking Buildbucket for the build status
[22:32:27.109] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:27.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:157:0) after 1m0s
[22:33:27.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:157:0)
[22:33:27.221] Timer tick, asking Buildbucket for the build status
[22:33:27.578] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:27.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:158:0) after 1m0s
[22:34:27.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:158:0)
[22:34:27.612] Timer tick, asking Buildbucket for the build status
[22:34:27.828] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:27.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:159:0) after 1m0s
[22:35:27.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:159:0)
[22:35:27.935] Timer tick, asking Buildbucket for the build status
[22:35:28.196] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:28.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:160:0) after 1m0s
[22:36:28.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:160:0)
[22:36:28.268] Timer tick, asking Buildbucket for the build status
[22:36:28.487] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:28.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:161:0) after 1m0s
[22:37:28.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:161:0)
[22:37:28.532] Timer tick, asking Buildbucket for the build status
[22:37:28.949] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:28.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:162:0) after 1m0s
[22:38:29.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:162:0)
[22:38:29.006] Timer tick, asking Buildbucket for the build status
[22:38:29.363] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:29.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:163:0) after 1m0s
[22:39:29.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:163:0)
[22:39:29.489] Timer tick, asking Buildbucket for the build status
[22:39:30.974] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:30.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:164:0) after 1m0s
[22:40:31.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:164:0)
[22:40:31.045] Timer tick, asking Buildbucket for the build status
[22:40:31.465] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:31.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:165:0) after 1m0s
[22:41:31.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:165:0)
[22:41:31.528] Timer tick, asking Buildbucket for the build status
[22:41:31.761] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:31.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:166:0) after 1m0s
[22:42:31.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:166:0)
[22:42:31.903] Timer tick, asking Buildbucket for the build status
[22:42:32.112] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:32.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:167:0) after 1m0s
[22:43:32.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:167:0)
[22:43:32.196] Timer tick, asking Buildbucket for the build status
[22:43:32.827] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:32.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:168:0) after 1m0s
[22:44:32.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:168:0)
[22:44:32.862] Timer tick, asking Buildbucket for the build status
[22:44:34.603] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:34.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:169:0) after 1m0s
[22:45:34.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:169:0)
[22:45:34.684] Timer tick, asking Buildbucket for the build status
[22:45:37.956] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:37.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:170:0) after 1m0s
[22:46:38.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:170:0)
[22:46:38.034] Timer tick, asking Buildbucket for the build status
[22:46:38.206] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:38.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:171:0) after 1m0s
[22:47:38.229] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:171:0)
[22:47:38.229] Timer tick, asking Buildbucket for the build status
[22:47:38.966] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:38.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:172:0) after 1m0s
[22:48:38.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:172:0)
[22:48:38.999] Timer tick, asking Buildbucket for the build status
[22:48:39.381] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:39.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:173:0) after 1m0s
[22:49:39.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:173:0)
[22:49:39.512] Timer tick, asking Buildbucket for the build status
[22:49:39.733] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:39.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:174:0) after 1m0s
[22:50:39.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:174:0)
[22:50:39.780] Timer tick, asking Buildbucket for the build status
[22:50:39.972] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:39.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:175:0) after 1m0s
[22:51:40.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:175:0)
[22:51:40.068] Timer tick, asking Buildbucket for the build status
[22:51:40.212] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:40.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:176:0) after 1m0s
[22:52:40.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:176:0)
[22:52:40.251] Timer tick, asking Buildbucket for the build status
[22:52:40.576] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:40.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:177:0) after 1m0s
[22:53:40.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:177:0)
[22:53:40.625] Timer tick, asking Buildbucket for the build status
[22:53:40.771] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:40.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:178:0) after 1m0s
[22:54:40.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:178:0)
[22:54:40.852] Timer tick, asking Buildbucket for the build status
[22:54:41.003] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:41.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:179:0) after 1m0s
[22:55:41.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:179:0)
[22:55:41.069] Timer tick, asking Buildbucket for the build status
[22:55:41.829] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:41.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:180:0) after 1m0s
[22:56:41.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:180:0)
[22:56:41.868] Timer tick, asking Buildbucket for the build status
[22:56:42.036] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:42.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:181:0) after 1m0s
[22:57:42.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:181:0)
[22:57:42.061] Timer tick, asking Buildbucket for the build status
[22:57:42.502] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:42.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:182:0) after 1m0s
[22:58:42.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:182:0)
[22:58:42.547] Timer tick, asking Buildbucket for the build status
[22:58:42.749] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:42.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:183:0) after 1m0s
[22:59:42.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:183:0)
[22:59:42.789] Timer tick, asking Buildbucket for the build status
[22:59:43.069] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:43.069] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:184:0) after 1m0s
[23:00:43.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:184:0)
[23:00:43.265] Timer tick, asking Buildbucket for the build status
[23:00:44.866] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:44.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:185:0) after 1m0s
[23:01:44.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:185:0)
[23:01:44.934] Timer tick, asking Buildbucket for the build status
[23:01:45.111] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:45.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:186:0) after 1m0s
[23:02:45.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:186:0)
[23:02:45.135] Timer tick, asking Buildbucket for the build status
[23:02:45.324] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:45.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:187:0) after 1m0s
[23:03:45.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:187:0)
[23:03:45.445] Timer tick, asking Buildbucket for the build status
[23:03:45.600] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:45.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:188:0) after 1m0s
[23:04:45.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:188:0)
[23:04:45.692] Timer tick, asking Buildbucket for the build status
[23:04:45.847] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:45.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:189:0) after 1m0s
[23:05:45.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:189:0)
[23:05:45.974] Timer tick, asking Buildbucket for the build status
[23:05:46.377] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:46.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:190:0) after 1m0s
[23:06:46.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:190:0)
[23:06:46.476] Timer tick, asking Buildbucket for the build status
[23:06:47.723] Build 8879209471558640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:47.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044639534375263712:191:0) after 1m0s
[23:07:15.759] Received PubSub notification, asking Buildbucket for the build status
[23:07:17.268] Build 8879209471558640592: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:07:17.268] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1590534434776613",
    "created_by": "project:infra",
    "created_ts": "1590522999191190",
    "id": "8879209471558640592",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4147.21\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"95545e09-de61-4e14-8e85-8fcdb1a35ee5\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4147.21\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4147.21\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"95545e09-de61-4e14-8e85-8fcdb1a35ee5\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-61da\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"84.0.4147.21\"}, \"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-61da\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"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\": [\"5125-829145d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1590523825755894",
    "status": "COMPLETED",
    "status_changed_ts": "1590534435396868",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9044639534375263712",
      "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/8879209471558640592/+/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:4c6b608f28418c10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1590534435414164",
    "url": "https://ci.chromium.org/b/8879209471558640592",
    "utcnow_ts": "1590534437245792"
  }
}
[23:07:17.268] Invocation finished in 3h10m40.146417863s with status SUCCEEDED