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

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

{
  "version": "83.0.4090.0"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[08:03:50.691] New invocation is queued and will start shortly
[08:03:50.691] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:03:52.342] Starting the invocation (attempt 1)
[08:03:52.380] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:03:52.380] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:03:52.380] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9050754374998194032",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"83.0.4090.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"8ed640e6-5969-4464-971a-c434bf5958f4\",\"title\":\"publish_tarball/0\"}]},\"version\":\"83.0.4090.0\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9050754374998194032",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[08:03:54.310] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1584691433582360",
    "id": "8885324311298573920",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4090.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"8ed640e6-5969-4464-971a-c434bf5958f4\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4090.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1584691434066326",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9050754374998194032",
      "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/8885324311298573920/+/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": "1584691434066584",
    "url": "https://ci.chromium.org/b/8885324311298573920",
    "utcnow_ts": "1584691434299634"
  }
}
[08:03:54.310] Task URL: https://ci.chromium.org/b/8885324311298573920
[08:03:54.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:2:0) after 1m0s
[08:04:54.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:2:0)
[08:04:54.301] Timer tick, asking Buildbucket for the build status
[08:04:54.440] Build 8885324311298573920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:04:54.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:3:0) after 1m0s
[08:05:14.055] Received PubSub notification, asking Buildbucket for the build status
[08:05:14.414] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:54.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:3:0)
[08:05:54.463] Timer tick, asking Buildbucket for the build status
[08:05:54.700] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:54.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:5:0) after 1m0s
[08:06:54.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:5:0)
[08:06:54.750] Timer tick, asking Buildbucket for the build status
[08:06:55.143] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:55.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:6:0) after 1m0s
[08:07:55.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:6:0)
[08:07:55.192] Timer tick, asking Buildbucket for the build status
[08:07:55.344] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:55.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:7:0) after 1m0s
[08:08:55.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:7:0)
[08:08:55.367] Timer tick, asking Buildbucket for the build status
[08:08:55.521] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:55.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:8:0) after 1m0s
[08:09:55.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:8:0)
[08:09:55.541] Timer tick, asking Buildbucket for the build status
[08:09:55.657] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:55.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:9:0) after 1m0s
[08:10:55.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:9:0)
[08:10:55.677] Timer tick, asking Buildbucket for the build status
[08:10:55.819] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:55.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:10:0) after 1m0s
[08:11:55.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:10:0)
[08:11:55.854] Timer tick, asking Buildbucket for the build status
[08:11:56.044] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:56.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:11:0) after 1m0s
[08:12:56.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:11:0)
[08:12:56.116] Timer tick, asking Buildbucket for the build status
[08:12:56.314] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:56.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:12:0) after 1m0s
[08:13:56.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:12:0)
[08:13:56.423] Timer tick, asking Buildbucket for the build status
[08:13:57.289] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:57.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:13:0) after 1m0s
[08:14:57.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:13:0)
[08:14:57.315] Timer tick, asking Buildbucket for the build status
[08:14:57.477] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:57.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:14:0) after 1m0s
[08:15:57.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:14:0)
[08:15:57.481] Timer tick, asking Buildbucket for the build status
[08:15:57.773] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:57.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:15:0) after 1m0s
[08:16:57.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:15:0)
[08:16:57.917] Timer tick, asking Buildbucket for the build status
[08:16:58.311] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:58.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:16:0) after 1m0s
[08:17:58.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:16:0)
[08:17:58.429] Timer tick, asking Buildbucket for the build status
[08:17:58.623] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:58.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:17:0) after 1m0s
[08:18:58.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:17:0)
[08:18:58.694] Timer tick, asking Buildbucket for the build status
[08:18:59.054] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:59.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:18:0) after 1m0s
[08:19:59.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:18:0)
[08:19:59.094] Timer tick, asking Buildbucket for the build status
[08:19:59.478] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:59.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:19:0) after 1m0s
[08:20:59.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:19:0)
[08:20:59.625] Timer tick, asking Buildbucket for the build status
[08:20:59.766] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:59.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:20:0) after 1m0s
[08:21:59.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:20:0)
[08:21:59.922] Timer tick, asking Buildbucket for the build status
[08:22:00.088] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:00.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:21:0) after 1m0s
[08:23:00.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:21:0)
[08:23:00.109] Timer tick, asking Buildbucket for the build status
[08:23:00.490] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:00.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:22:0) after 1m0s
[08:24:00.504] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:22:0)
[08:24:00.504] Timer tick, asking Buildbucket for the build status
[08:24:00.851] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:00.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:23:0) after 1m0s
[08:25:00.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:23:0)
[08:25:00.972] Timer tick, asking Buildbucket for the build status
[08:25:01.222] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:01.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:24:0) after 1m0s
[08:26:01.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:24:0)
[08:26:01.318] Timer tick, asking Buildbucket for the build status
[08:26:01.884] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:01.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:25:0) after 1m0s
[08:27:01.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:25:0)
[08:27:01.914] Timer tick, asking Buildbucket for the build status
[08:27:02.560] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:02.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:26:0) after 1m0s
[08:28:02.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:26:0)
[08:28:02.586] Timer tick, asking Buildbucket for the build status
[08:28:02.981] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:02.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:27:0) after 1m0s
[08:29:03.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:27:0)
[08:29:03.079] Timer tick, asking Buildbucket for the build status
[08:29:03.303] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:03.303] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:28:0) after 1m0s
[08:30:03.332] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:28:0)
[08:30:03.332] Timer tick, asking Buildbucket for the build status
[08:30:03.547] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:03.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:29:0) after 1m0s
[08:31:03.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:29:0)
[08:31:03.576] Timer tick, asking Buildbucket for the build status
[08:31:03.678] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:03.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:30:0) after 1m0s
[08:32:03.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:30:0)
[08:32:03.668] Timer tick, asking Buildbucket for the build status
[08:32:03.848] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:03.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:31:0) after 1m0s
[08:33:03.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:31:0)
[08:33:03.911] Timer tick, asking Buildbucket for the build status
[08:33:04.293] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:04.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:32:0) after 1m0s
[08:34:04.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:32:0)
[08:34:04.371] Timer tick, asking Buildbucket for the build status
[08:34:04.577] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:04.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:33:0) after 1m0s
[08:35:04.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:33:0)
[08:35:04.744] Timer tick, asking Buildbucket for the build status
[08:35:04.903] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:04.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:34:0) after 1m0s
[08:36:04.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:34:0)
[08:36:04.971] Timer tick, asking Buildbucket for the build status
[08:36:05.229] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:05.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:35:0) after 1m0s
[08:37:05.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:35:0)
[08:37:05.350] Timer tick, asking Buildbucket for the build status
[08:37:07.314] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:07.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:36:0) after 1m0s
[08:38:07.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:36:0)
[08:38:07.337] Timer tick, asking Buildbucket for the build status
[08:38:07.682] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:07.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:37:0) after 1m0s
[08:39:07.799] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:37:0)
[08:39:07.799] Timer tick, asking Buildbucket for the build status
[08:39:08.246] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:08.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:38:0) after 1m0s
[08:40:08.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:38:0)
[08:40:08.351] Timer tick, asking Buildbucket for the build status
[08:40:08.583] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:08.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:39:0) after 1m0s
[08:41:08.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:39:0)
[08:41:08.603] Timer tick, asking Buildbucket for the build status
[08:41:08.988] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:08.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:40:0) after 1m0s
[08:42:09.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:40:0)
[08:42:09.055] Timer tick, asking Buildbucket for the build status
[08:42:09.352] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:09.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:41:0) after 1m0s
[08:43:09.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:41:0)
[08:43:09.390] Timer tick, asking Buildbucket for the build status
[08:43:09.586] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:09.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:42:0) after 1m0s
[08:44:09.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:42:0)
[08:44:09.607] Timer tick, asking Buildbucket for the build status
[08:44:09.982] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:09.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:43:0) after 1m0s
[08:45:10.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:43:0)
[08:45:10.061] Timer tick, asking Buildbucket for the build status
[08:45:10.317] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:10.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:44:0) after 1m0s
[08:46:10.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:44:0)
[08:46:10.341] Timer tick, asking Buildbucket for the build status
[08:46:10.514] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:10.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:45:0) after 1m0s
[08:47:10.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:45:0)
[08:47:10.585] Timer tick, asking Buildbucket for the build status
[08:47:10.717] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:10.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:46:0) after 1m0s
[08:48:11.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:46:0)
[08:48:11.037] Timer tick, asking Buildbucket for the build status
[08:48:11.204] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:11.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:47:0) after 1m0s
[08:49:11.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:47:0)
[08:49:11.255] Timer tick, asking Buildbucket for the build status
[08:49:11.677] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:11.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:48:0) after 1m0s
[08:50:11.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:48:0)
[08:50:11.746] Timer tick, asking Buildbucket for the build status
[08:50:11.921] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:11.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:49:0) after 1m0s
[08:51:12.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:49:0)
[08:51:12.025] Timer tick, asking Buildbucket for the build status
[08:51:12.201] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:12.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:50:0) after 1m0s
[08:52:12.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:50:0)
[08:52:12.357] Timer tick, asking Buildbucket for the build status
[08:52:12.762] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:12.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:51:0) after 1m0s
[08:53:12.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:51:0)
[08:53:12.871] Timer tick, asking Buildbucket for the build status
[08:53:13.049] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:13.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:52:0) after 1m0s
[08:54:13.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:52:0)
[08:54:13.089] Timer tick, asking Buildbucket for the build status
[08:54:13.282] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:13.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:53:0) after 1m0s
[08:55:13.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:53:0)
[08:55:13.311] Timer tick, asking Buildbucket for the build status
[08:55:13.757] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:13.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:54:0) after 1m0s
[08:56:13.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:54:0)
[08:56:13.984] Timer tick, asking Buildbucket for the build status
[08:56:14.213] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:14.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:55:0) after 1m0s
[08:57:14.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:55:0)
[08:57:14.223] Timer tick, asking Buildbucket for the build status
[08:57:14.392] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:14.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:56:0) after 1m0s
[08:58:14.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:56:0)
[08:58:14.434] Timer tick, asking Buildbucket for the build status
[08:58:14.607] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:14.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:57:0) after 1m0s
[08:59:14.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:57:0)
[08:59:14.638] Timer tick, asking Buildbucket for the build status
[08:59:14.822] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:14.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:58:0) after 1m0s
[09:00:14.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:58:0)
[09:00:14.862] Timer tick, asking Buildbucket for the build status
[09:00:15.177] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:15.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:59:0) after 1m0s
[09:01:15.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:59:0)
[09:01:15.184] Timer tick, asking Buildbucket for the build status
[09:01:15.318] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:15.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:60:0) after 1m0s
[09:02:15.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:60:0)
[09:02:15.344] Timer tick, asking Buildbucket for the build status
[09:02:16.014] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:16.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:61:0) after 1m0s
[09:03:15.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:61:0)
[09:03:15.995] Timer tick, asking Buildbucket for the build status
[09:03:16.185] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:16.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:62:0) after 1m0s
[09:04:16.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:62:0)
[09:04:16.238] Timer tick, asking Buildbucket for the build status
[09:04:16.393] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:16.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:63:0) after 1m0s
[09:05:16.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:63:0)
[09:05:16.516] Timer tick, asking Buildbucket for the build status
[09:05:16.788] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:16.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:64:0) after 1m0s
[09:06:16.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:64:0)
[09:06:16.907] Timer tick, asking Buildbucket for the build status
[09:06:16.985] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:16.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:65:0) after 1m0s
[09:07:17.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:65:0)
[09:07:17.147] Timer tick, asking Buildbucket for the build status
[09:07:17.386] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:17.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:66:0) after 1m0s
[09:08:17.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:66:0)
[09:08:17.682] Timer tick, asking Buildbucket for the build status
[09:08:17.858] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:17.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:67:0) after 1m0s
[09:09:17.978] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:67:0)
[09:09:17.978] Timer tick, asking Buildbucket for the build status
[09:09:18.146] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:18.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:68:0) after 1m0s
[09:10:18.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:68:0)
[09:10:18.293] Timer tick, asking Buildbucket for the build status
[09:10:18.511] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:18.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:69:0) after 1m0s
[09:11:18.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:69:0)
[09:11:18.557] Timer tick, asking Buildbucket for the build status
[09:11:18.735] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:18.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:70:0) after 1m0s
[09:12:19.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:70:0)
[09:12:19.224] Timer tick, asking Buildbucket for the build status
[09:12:19.428] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:19.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:71:0) after 1m0s
[09:13:19.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:71:0)
[09:13:19.534] Timer tick, asking Buildbucket for the build status
[09:13:19.705] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:19.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:72:0) after 1m0s
[09:14:19.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:72:0)
[09:14:19.703] Timer tick, asking Buildbucket for the build status
[09:14:19.821] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:19.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:73:0) after 1m0s
[09:15:19.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:73:0)
[09:15:19.883] Timer tick, asking Buildbucket for the build status
[09:15:20.067] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:20.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:74:0) after 1m0s
[09:16:20.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:74:0)
[09:16:20.074] Timer tick, asking Buildbucket for the build status
[09:16:20.414] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:20.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:75:0) after 1m0s
[09:17:20.504] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:75:0)
[09:17:20.504] Timer tick, asking Buildbucket for the build status
[09:17:20.784] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:20.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:76:0) after 1m0s
[09:18:20.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:76:0)
[09:18:20.788] Timer tick, asking Buildbucket for the build status
[09:18:20.995] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:20.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:77:0) after 1m0s
[09:19:21.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:77:0)
[09:19:21.084] Timer tick, asking Buildbucket for the build status
[09:19:21.281] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:21.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:78:0) after 1m0s
[09:20:21.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:78:0)
[09:20:21.400] Timer tick, asking Buildbucket for the build status
[09:20:21.542] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:21.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:79:0) after 1m0s
[09:21:21.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:79:0)
[09:21:21.815] Timer tick, asking Buildbucket for the build status
[09:21:22.071] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:22.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:80:0) after 1m0s
[09:22:22.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:80:0)
[09:22:22.175] Timer tick, asking Buildbucket for the build status
[09:22:23.423] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:23.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:81:0) after 1m0s
[09:23:23.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:81:0)
[09:23:23.492] Timer tick, asking Buildbucket for the build status
[09:23:23.672] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:23.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:82:0) after 1m0s
[09:24:23.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:82:0)
[09:24:23.802] Timer tick, asking Buildbucket for the build status
[09:24:23.948] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:23.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:83:0) after 1m0s
[09:25:24.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:83:0)
[09:25:24.059] Timer tick, asking Buildbucket for the build status
[09:25:24.211] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:24.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:84:0) after 1m0s
[09:26:24.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:84:0)
[09:26:24.237] Timer tick, asking Buildbucket for the build status
[09:26:24.360] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:24.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:85:0) after 1m0s
[09:27:24.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:85:0)
[09:27:24.420] Timer tick, asking Buildbucket for the build status
[09:27:25.177] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:25.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:86:0) after 1m0s
[09:28:25.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:86:0)
[09:28:25.230] Timer tick, asking Buildbucket for the build status
[09:28:25.308] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:25.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:87:0) after 1m0s
[09:29:25.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:87:0)
[09:29:25.343] Timer tick, asking Buildbucket for the build status
[09:29:25.485] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:25.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:88:0) after 1m0s
[09:30:25.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:88:0)
[09:30:25.503] Timer tick, asking Buildbucket for the build status
[09:30:25.636] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:25.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:89:0) after 1m0s
[09:31:25.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:89:0)
[09:31:25.675] Timer tick, asking Buildbucket for the build status
[09:31:26.137] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:26.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:90:0) after 1m0s
[09:32:26.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:90:0)
[09:32:26.156] Timer tick, asking Buildbucket for the build status
[09:32:26.347] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:26.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:91:0) after 1m0s
[09:33:26.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:91:0)
[09:33:26.411] Timer tick, asking Buildbucket for the build status
[09:33:26.561] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:26.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:92:0) after 1m0s
[09:34:26.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:92:0)
[09:34:26.611] Timer tick, asking Buildbucket for the build status
[09:34:26.770] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:26.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:93:0) after 1m0s
[09:35:26.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:93:0)
[09:35:26.769] Timer tick, asking Buildbucket for the build status
[09:35:26.990] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:26.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:94:0) after 1m0s
[09:36:27.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:94:0)
[09:36:27.101] Timer tick, asking Buildbucket for the build status
[09:36:27.314] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:27.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:95:0) after 1m0s
[09:37:27.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:95:0)
[09:37:27.402] Timer tick, asking Buildbucket for the build status
[09:37:28.667] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:28.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:96:0) after 1m0s
[09:38:28.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:96:0)
[09:38:28.757] Timer tick, asking Buildbucket for the build status
[09:38:29.006] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:29.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:97:0) after 1m0s
[09:39:29.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:97:0)
[09:39:29.075] Timer tick, asking Buildbucket for the build status
[09:39:29.257] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:29.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:98:0) after 1m0s
[09:40:29.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:98:0)
[09:40:29.352] Timer tick, asking Buildbucket for the build status
[09:40:29.612] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:29.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:99:0) after 1m0s
[09:41:29.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:99:0)
[09:41:29.634] Timer tick, asking Buildbucket for the build status
[09:41:29.706] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:29.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:100:0) after 1m0s
[09:42:29.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:100:0)
[09:42:29.797] Timer tick, asking Buildbucket for the build status
[09:42:30.256] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:30.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:101:0) after 1m0s
[09:43:30.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:101:0)
[09:43:30.285] Timer tick, asking Buildbucket for the build status
[09:43:30.815] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:30.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:102:0) after 1m0s
[09:44:30.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:102:0)
[09:44:30.833] Timer tick, asking Buildbucket for the build status
[09:44:31.855] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:31.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:103:0) after 1m0s
[09:45:31.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:103:0)
[09:45:31.864] Timer tick, asking Buildbucket for the build status
[09:45:32.005] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:32.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:104:0) after 1m0s
[09:46:32.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:104:0)
[09:46:32.055] Timer tick, asking Buildbucket for the build status
[09:46:32.274] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:32.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:105:0) after 1m0s
[09:47:32.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:105:0)
[09:47:32.298] Timer tick, asking Buildbucket for the build status
[09:47:35.542] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:35.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:106:0) after 1m0s
[09:48:35.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:106:0)
[09:48:35.692] Timer tick, asking Buildbucket for the build status
[09:48:35.787] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:35.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:107:0) after 1m0s
[09:49:35.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:107:0)
[09:49:35.845] Timer tick, asking Buildbucket for the build status
[09:49:36.290] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:36.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:108:0) after 1m0s
[09:50:36.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:108:0)
[09:50:36.340] Timer tick, asking Buildbucket for the build status
[09:50:36.447] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:36.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:109:0) after 1m0s
[09:51:36.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:109:0)
[09:51:36.478] Timer tick, asking Buildbucket for the build status
[09:51:36.607] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:36.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:110:0) after 1m0s
[09:52:36.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:110:0)
[09:52:36.665] Timer tick, asking Buildbucket for the build status
[09:52:37.048] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:37.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:111:0) after 1m0s
[09:53:37.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:111:0)
[09:53:37.064] Timer tick, asking Buildbucket for the build status
[09:53:37.322] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:37.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:112:0) after 1m0s
[09:54:37.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:112:0)
[09:54:37.383] Timer tick, asking Buildbucket for the build status
[09:54:37.521] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:37.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:113:0) after 1m0s
[09:55:37.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:113:0)
[09:55:37.581] Timer tick, asking Buildbucket for the build status
[09:55:37.801] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:37.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:114:0) after 1m0s
[09:56:37.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:114:0)
[09:56:37.832] Timer tick, asking Buildbucket for the build status
[09:56:37.979] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:37.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:115:0) after 1m0s
[09:57:38.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:115:0)
[09:57:38.002] Timer tick, asking Buildbucket for the build status
[09:57:40.202] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:40.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:116:0) after 1m0s
[09:58:40.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:116:0)
[09:58:40.293] Timer tick, asking Buildbucket for the build status
[09:58:40.618] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:40.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:117:0) after 1m0s
[09:59:40.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:117:0)
[09:59:40.730] Timer tick, asking Buildbucket for the build status
[09:59:40.811] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:40.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:118:0) after 1m0s
[10:00:40.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:118:0)
[10:00:40.899] Timer tick, asking Buildbucket for the build status
[10:00:41.069] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:41.069] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:119:0) after 1m0s
[10:01:41.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:119:0)
[10:01:41.406] Timer tick, asking Buildbucket for the build status
[10:01:41.915] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:41.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:120:0) after 1m0s
[10:02:42.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:120:0)
[10:02:42.008] Timer tick, asking Buildbucket for the build status
[10:02:43.341] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:43.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:121:0) after 1m0s
[10:03:43.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:121:0)
[10:03:43.541] Timer tick, asking Buildbucket for the build status
[10:03:43.871] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:43.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:122:0) after 1m0s
[10:04:43.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:122:0)
[10:04:43.953] Timer tick, asking Buildbucket for the build status
[10:04:44.169] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:44.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:123:0) after 1m0s
[10:05:44.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:123:0)
[10:05:44.236] Timer tick, asking Buildbucket for the build status
[10:05:44.312] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:44.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:124:0) after 1m0s
[10:06:44.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:124:0)
[10:06:44.372] Timer tick, asking Buildbucket for the build status
[10:06:44.547] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:44.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:125:0) after 1m0s
[10:07:44.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:125:0)
[10:07:44.573] Timer tick, asking Buildbucket for the build status
[10:07:44.780] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:44.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:126:0) after 1m0s
[10:08:44.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:126:0)
[10:08:44.806] Timer tick, asking Buildbucket for the build status
[10:08:45.060] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:45.060] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:127:0) after 1m0s
[10:09:45.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:127:0)
[10:09:45.091] Timer tick, asking Buildbucket for the build status
[10:09:45.253] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:45.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:128:0) after 1m0s
[10:10:45.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:128:0)
[10:10:45.312] Timer tick, asking Buildbucket for the build status
[10:10:45.426] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:45.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:129:0) after 1m0s
[10:11:45.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:129:0)
[10:11:45.493] Timer tick, asking Buildbucket for the build status
[10:11:45.616] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:45.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:130:0) after 1m0s
[10:12:45.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:130:0)
[10:12:45.710] Timer tick, asking Buildbucket for the build status
[10:12:46.878] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:46.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:131:0) after 1m0s
[10:13:46.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:131:0)
[10:13:46.874] Timer tick, asking Buildbucket for the build status
[10:13:47.023] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:47.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:132:0) after 1m0s
[10:14:47.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:132:0)
[10:14:47.304] Timer tick, asking Buildbucket for the build status
[10:14:47.629] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:47.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:133:0) after 1m0s
[10:15:47.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:133:0)
[10:15:47.634] Timer tick, asking Buildbucket for the build status
[10:15:48.268] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:48.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:134:0) after 1m0s
[10:16:48.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:134:0)
[10:16:48.352] Timer tick, asking Buildbucket for the build status
[10:16:48.421] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:48.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:135:0) after 1m0s
[10:17:48.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:135:0)
[10:17:48.611] Timer tick, asking Buildbucket for the build status
[10:17:50.914] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:50.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:136:0) after 1m0s
[10:18:51.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:136:0)
[10:18:51.677] Timer tick, asking Buildbucket for the build status
[10:18:52.448] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:52.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:137:0) after 1m0s
[10:19:52.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:137:0)
[10:19:52.698] Timer tick, asking Buildbucket for the build status
[10:19:52.942] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:52.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:138:0) after 1m0s
[10:20:53.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:138:0)
[10:20:53.101] Timer tick, asking Buildbucket for the build status
[10:20:53.283] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:53.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:139:0) after 1m0s
[10:21:53.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:139:0)
[10:21:53.297] Timer tick, asking Buildbucket for the build status
[10:21:53.473] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:53.473] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:140:0) after 1m0s
[10:22:53.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:140:0)
[10:22:53.539] Timer tick, asking Buildbucket for the build status
[10:22:53.629] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:53.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:141:0) after 1m0s
[10:23:53.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:141:0)
[10:23:53.940] Timer tick, asking Buildbucket for the build status
[10:23:54.135] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:54.135] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:142:0) after 1m0s
[10:24:54.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:142:0)
[10:24:54.296] Timer tick, asking Buildbucket for the build status
[10:24:54.914] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:54.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:143:0) after 1m0s
[10:25:54.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:143:0)
[10:25:54.996] Timer tick, asking Buildbucket for the build status
[10:25:55.196] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:55.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:144:0) after 1m0s
[10:26:55.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:144:0)
[10:26:55.453] Timer tick, asking Buildbucket for the build status
[10:26:55.554] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:55.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:145:0) after 1m0s
[10:27:55.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:145:0)
[10:27:55.686] Timer tick, asking Buildbucket for the build status
[10:27:55.853] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:55.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:146:0) after 1m0s
[10:28:56.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:146:0)
[10:28:56.068] Timer tick, asking Buildbucket for the build status
[10:28:56.195] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:56.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:147:0) after 1m0s
[10:29:56.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:147:0)
[10:29:56.257] Timer tick, asking Buildbucket for the build status
[10:29:56.414] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:56.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:148:0) after 1m0s
[10:30:56.456] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:148:0)
[10:30:56.456] Timer tick, asking Buildbucket for the build status
[10:30:56.887] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:56.887] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:149:0) after 1m0s
[10:31:57.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:149:0)
[10:31:57.063] Timer tick, asking Buildbucket for the build status
[10:31:57.199] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:57.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:150:0) after 1m0s
[10:32:57.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:150:0)
[10:32:57.311] Timer tick, asking Buildbucket for the build status
[10:32:57.532] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:57.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:151:0) after 1m0s
[10:33:57.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:151:0)
[10:33:57.576] Timer tick, asking Buildbucket for the build status
[10:33:57.768] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:57.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:152:0) after 1m0s
[10:34:57.826] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:152:0)
[10:34:57.826] Timer tick, asking Buildbucket for the build status
[10:34:58.001] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:58.001] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:153:0) after 1m0s
[10:35:58.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:153:0)
[10:35:58.035] Timer tick, asking Buildbucket for the build status
[10:35:58.156] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:58.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:154:0) after 1m0s
[10:36:58.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:154:0)
[10:36:58.217] Timer tick, asking Buildbucket for the build status
[10:36:58.368] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:58.368] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:155:0) after 1m0s
[10:37:58.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:155:0)
[10:37:58.355] Timer tick, asking Buildbucket for the build status
[10:37:58.922] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:58.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:156:0) after 1m0s
[10:38:59.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:156:0)
[10:38:59.017] Timer tick, asking Buildbucket for the build status
[10:38:59.237] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:59.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:157:0) after 1m0s
[10:39:59.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:157:0)
[10:39:59.303] Timer tick, asking Buildbucket for the build status
[10:39:59.441] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:59.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:158:0) after 1m0s
[10:40:59.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:158:0)
[10:40:59.724] Timer tick, asking Buildbucket for the build status
[10:40:59.860] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:59.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:159:0) after 1m0s
[10:41:59.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:159:0)
[10:41:59.941] Timer tick, asking Buildbucket for the build status
[10:42:00.094] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:00.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:160:0) after 1m0s
[10:43:00.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:160:0)
[10:43:00.159] Timer tick, asking Buildbucket for the build status
[10:43:00.323] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:00.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:161:0) after 1m0s
[10:44:00.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:161:0)
[10:44:00.376] Timer tick, asking Buildbucket for the build status
[10:44:00.565] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:00.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:162:0) after 1m0s
[10:45:00.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:162:0)
[10:45:00.751] Timer tick, asking Buildbucket for the build status
[10:45:00.828] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:00.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:163:0) after 1m0s
[10:46:00.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:163:0)
[10:46:00.863] Timer tick, asking Buildbucket for the build status
[10:46:01.028] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:01.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:164:0) after 1m0s
[10:47:01.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:164:0)
[10:47:01.379] Timer tick, asking Buildbucket for the build status
[10:47:01.857] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:01.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:165:0) after 1m0s
[10:48:01.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:165:0)
[10:48:01.953] Timer tick, asking Buildbucket for the build status
[10:48:02.108] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:02.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:166:0) after 1m0s
[10:49:02.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:166:0)
[10:49:02.262] Timer tick, asking Buildbucket for the build status
[10:49:02.362] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:02.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:167:0) after 1m0s
[10:50:02.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:167:0)
[10:50:02.435] Timer tick, asking Buildbucket for the build status
[10:50:02.752] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:02.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:168:0) after 1m0s
[10:51:02.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:168:0)
[10:51:02.788] Timer tick, asking Buildbucket for the build status
[10:51:02.949] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:02.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:169:0) after 1m0s
[10:52:02.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:169:0)
[10:52:02.956] Timer tick, asking Buildbucket for the build status
[10:52:03.243] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:03.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:170:0) after 1m0s
[10:53:03.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:170:0)
[10:53:03.354] Timer tick, asking Buildbucket for the build status
[10:53:03.639] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:03.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:171:0) after 1m0s
[10:54:03.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:171:0)
[10:54:03.669] Timer tick, asking Buildbucket for the build status
[10:54:03.766] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:03.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:172:0) after 1m0s
[10:55:03.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:172:0)
[10:55:03.805] Timer tick, asking Buildbucket for the build status
[10:55:04.253] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:04.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:173:0) after 1m0s
[10:56:04.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:173:0)
[10:56:04.350] Timer tick, asking Buildbucket for the build status
[10:56:04.550] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:04.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:174:0) after 1m0s
[10:57:04.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:174:0)
[10:57:04.585] Timer tick, asking Buildbucket for the build status
[10:57:04.689] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:04.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:175:0) after 1m0s
[10:58:04.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:175:0)
[10:58:04.735] Timer tick, asking Buildbucket for the build status
[10:58:05.118] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:05.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:176:0) after 1m0s
[10:59:05.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:176:0)
[10:59:05.145] Timer tick, asking Buildbucket for the build status
[10:59:05.751] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:05.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:177:0) after 1m0s
[11:00:05.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:177:0)
[11:00:05.847] Timer tick, asking Buildbucket for the build status
[11:00:06.063] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:06.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:178:0) after 1m0s
[11:01:06.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:178:0)
[11:01:06.082] Timer tick, asking Buildbucket for the build status
[11:01:06.144] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:06.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:179:0) after 1m0s
[11:02:06.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:179:0)
[11:02:06.212] Timer tick, asking Buildbucket for the build status
[11:02:06.328] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:06.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:180:0) after 1m0s
[11:03:06.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:180:0)
[11:03:06.390] Timer tick, asking Buildbucket for the build status
[11:03:06.953] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:06.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:181:0) after 1m0s
[11:04:07.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:181:0)
[11:04:07.087] Timer tick, asking Buildbucket for the build status
[11:04:07.272] Build 8885324311298573920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:07.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050754374998194032:182:0) after 1m0s
[11:04:44.502] Received PubSub notification, asking Buildbucket for the build status
[11:04:44.633] Build 8885324311298573920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:04:44.633] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1584702283623109",
    "created_by": "project:infra",
    "created_ts": "1584691433582360",
    "id": "8885324311298573920",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4090.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"8ed640e6-5969-4464-971a-c434bf5958f4\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4090.0\"}}",
    "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\": \"83.0.4090.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"8ed640e6-5969-4464-971a-c434bf5958f4\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-c49g\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"83.0.4090.0\"}, \"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-c49g\"], \"image\": [\"chrome-xenial-20031500-6b26172a85c\"], \"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\": [\"4874-3598771\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1584691513307560",
    "status": "COMPLETED",
    "status_changed_ts": "1584702284120339",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9050754374998194032",
      "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/8885324311298573920/+/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:4b0fc9dcc2ef7c10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1584702284154804",
    "url": "https://ci.chromium.org/b/8885324311298573920",
    "utcnow_ts": "1584702284622161"
  }
}
[11:04:44.633] Invocation finished in 3h0m53.96334426s with status SUCCEEDED