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

• parent_buildername:publish_tarball
• user_agent:recipe

[12:01:44.861] New invocation is queued and will start shortly
[12:01:44.861] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[12:01:46.016] Starting the invocation (attempt 1)
[12:01:46.096] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:01:46.096] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:01:46.097] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9039414786644213440",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4209.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"0ca31f48-f791-4a7a-8dbd-e6a227a89b54\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4209.2\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9039414786644213440",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[12:01:46.930] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1595505706339069",
    "id": "8873984724428079328",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4209.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"0ca31f48-f791-4a7a-8dbd-e6a227a89b54\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4209.2\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1595505706602737",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9039414786644213440",
      "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/8873984724428079328/+/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": "1595505706602866",
    "url": "https://ci.chromium.org/b/8873984724428079328",
    "utcnow_ts": "1595505706870685"
  }
}
[12:01:46.930] Task URL: https://ci.chromium.org/b/8873984724428079328
[12:01:46.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:2:0) after 1m0s
[12:02:35.228] Received PubSub notification, asking Buildbucket for the build status
[12:02:35.363] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:47.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:2:0)
[12:02:47.004] Timer tick, asking Buildbucket for the build status
[12:02:47.420] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:47.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:4:0) after 1m0s
[12:03:47.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:4:0)
[12:03:47.462] Timer tick, asking Buildbucket for the build status
[12:03:47.922] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:47.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:5:0) after 1m0s
[12:04:47.944] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:5:0)
[12:04:47.944] Timer tick, asking Buildbucket for the build status
[12:04:48.128] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:48.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:6:0) after 1m0s
[12:05:48.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:6:0)
[12:05:48.199] Timer tick, asking Buildbucket for the build status
[12:05:48.587] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:48.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:7:0) after 1m0s
[12:06:48.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:7:0)
[12:06:48.870] Timer tick, asking Buildbucket for the build status
[12:06:49.046] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:49.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:8:0) after 1m0s
[12:07:49.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:8:0)
[12:07:49.231] Timer tick, asking Buildbucket for the build status
[12:07:49.537] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:49.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:9:0) after 1m0s
[12:08:49.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:9:0)
[12:08:49.737] Timer tick, asking Buildbucket for the build status
[12:08:49.975] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:49.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:10:0) after 1m0s
[12:09:50.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:10:0)
[12:09:50.037] Timer tick, asking Buildbucket for the build status
[12:09:50.113] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:50.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:11:0) after 1m0s
[12:10:50.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:11:0)
[12:10:50.197] Timer tick, asking Buildbucket for the build status
[12:10:50.503] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:50.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:12:0) after 1m0s
[12:11:50.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:12:0)
[12:11:50.492] Timer tick, asking Buildbucket for the build status
[12:11:50.878] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:50.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:13:0) after 1m0s
[12:12:51.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:13:0)
[12:12:51.028] Timer tick, asking Buildbucket for the build status
[12:12:51.179] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:51.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:14:0) after 1m0s
[12:13:51.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:14:0)
[12:13:51.227] Timer tick, asking Buildbucket for the build status
[12:13:51.486] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:51.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:15:0) after 1m0s
[12:14:51.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:15:0)
[12:14:51.548] Timer tick, asking Buildbucket for the build status
[12:14:51.610] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:51.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:16:0) after 1m0s
[12:15:51.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:16:0)
[12:15:51.752] Timer tick, asking Buildbucket for the build status
[12:15:51.928] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:51.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:17:0) after 1m0s
[12:16:52.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:17:0)
[12:16:52.094] Timer tick, asking Buildbucket for the build status
[12:16:52.252] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:52.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:18:0) after 1m0s
[12:17:52.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:18:0)
[12:17:52.430] Timer tick, asking Buildbucket for the build status
[12:17:52.593] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:52.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:19:0) after 1m0s
[12:18:52.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:19:0)
[12:18:52.617] Timer tick, asking Buildbucket for the build status
[12:18:52.919] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:52.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:20:0) after 1m0s
[12:19:53.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:20:0)
[12:19:53.200] Timer tick, asking Buildbucket for the build status
[12:19:53.324] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:53.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:21:0) after 1m0s
[12:20:53.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:21:0)
[12:20:53.546] Timer tick, asking Buildbucket for the build status
[12:20:53.705] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:53.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:22:0) after 1m0s
[12:21:53.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:22:0)
[12:21:53.830] Timer tick, asking Buildbucket for the build status
[12:21:54.018] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:54.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:23:0) after 1m0s
[12:22:54.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:23:0)
[12:22:54.109] Timer tick, asking Buildbucket for the build status
[12:22:54.192] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:54.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:24:0) after 1m0s
[12:23:54.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:24:0)
[12:23:54.363] Timer tick, asking Buildbucket for the build status
[12:23:54.494] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:54.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:25:0) after 1m0s
[12:24:54.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:25:0)
[12:24:54.602] Timer tick, asking Buildbucket for the build status
[12:24:54.778] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:54.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:26:0) after 1m0s
[12:25:54.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:26:0)
[12:25:54.829] Timer tick, asking Buildbucket for the build status
[12:25:55.113] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:55.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:27:0) after 1m0s
[12:26:55.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:27:0)
[12:26:55.355] Timer tick, asking Buildbucket for the build status
[12:26:55.469] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:55.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:28:0) after 1m0s
[12:27:55.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:28:0)
[12:27:55.506] Timer tick, asking Buildbucket for the build status
[12:27:55.728] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:55.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:29:0) after 1m0s
[12:28:55.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:29:0)
[12:28:55.866] Timer tick, asking Buildbucket for the build status
[12:28:56.020] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:56.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:30:0) after 1m0s
[12:29:56.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:30:0)
[12:29:56.078] Timer tick, asking Buildbucket for the build status
[12:29:56.179] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:56.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:31:0) after 1m0s
[12:30:56.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:31:0)
[12:30:56.411] Timer tick, asking Buildbucket for the build status
[12:30:56.574] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:56.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:32:0) after 1m0s
[12:31:56.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:32:0)
[12:31:56.697] Timer tick, asking Buildbucket for the build status
[12:31:56.813] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:56.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:33:0) after 1m0s
[12:32:57.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:33:0)
[12:32:57.155] Timer tick, asking Buildbucket for the build status
[12:32:57.372] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:57.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:34:0) after 1m0s
[12:33:57.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:34:0)
[12:33:57.418] Timer tick, asking Buildbucket for the build status
[12:33:57.623] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:57.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:35:0) after 1m0s
[12:34:57.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:35:0)
[12:34:57.711] Timer tick, asking Buildbucket for the build status
[12:34:57.793] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:57.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:36:0) after 1m0s
[12:35:58.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:36:0)
[12:35:58.567] Timer tick, asking Buildbucket for the build status
[12:35:58.652] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:58.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:37:0) after 1m0s
[12:36:58.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:37:0)
[12:36:58.758] Timer tick, asking Buildbucket for the build status
[12:36:58.888] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:58.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:38:0) after 1m0s
[12:37:59.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:38:0)
[12:37:59.058] Timer tick, asking Buildbucket for the build status
[12:37:59.215] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:59.215] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:39:0) after 1m0s
[12:38:59.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:39:0)
[12:38:59.328] Timer tick, asking Buildbucket for the build status
[12:38:59.392] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:59.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:40:0) after 1m0s
[12:39:59.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:40:0)
[12:39:59.554] Timer tick, asking Buildbucket for the build status
[12:39:59.638] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:59.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:41:0) after 1m0s
[12:40:59.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:41:0)
[12:40:59.638] Timer tick, asking Buildbucket for the build status
[12:40:59.722] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:59.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:42:0) after 1m0s
[12:41:59.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:42:0)
[12:41:59.877] Timer tick, asking Buildbucket for the build status
[12:42:00.127] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:00.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:43:0) after 1m0s
[12:43:00.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:43:0)
[12:43:00.172] Timer tick, asking Buildbucket for the build status
[12:43:00.235] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:00.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:44:0) after 1m0s
[12:44:00.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:44:0)
[12:44:00.258] Timer tick, asking Buildbucket for the build status
[12:44:00.332] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:00.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:45:0) after 1m0s
[12:45:01.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:45:0)
[12:45:01.564] Timer tick, asking Buildbucket for the build status
[12:45:01.657] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:01.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:46:0) after 1m0s
[12:46:01.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:46:0)
[12:46:01.901] Timer tick, asking Buildbucket for the build status
[12:46:02.026] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:02.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:47:0) after 1m0s
[12:47:02.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:47:0)
[12:47:02.232] Timer tick, asking Buildbucket for the build status
[12:47:02.363] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:02.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:48:0) after 1m0s
[12:48:02.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:48:0)
[12:48:02.441] Timer tick, asking Buildbucket for the build status
[12:48:02.514] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:02.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:49:0) after 1m0s
[12:49:02.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:49:0)
[12:49:02.602] Timer tick, asking Buildbucket for the build status
[12:49:02.683] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:02.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:50:0) after 1m0s
[12:50:02.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:50:0)
[12:50:02.739] Timer tick, asking Buildbucket for the build status
[12:50:02.908] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:02.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:51:0) after 1m0s
[12:51:03.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:51:0)
[12:51:03.006] Timer tick, asking Buildbucket for the build status
[12:51:03.124] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:03.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:52:0) after 1m0s
[12:52:03.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:52:0)
[12:52:03.152] Timer tick, asking Buildbucket for the build status
[12:52:03.273] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:03.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:53:0) after 1m0s
[12:53:03.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:53:0)
[12:53:03.297] Timer tick, asking Buildbucket for the build status
[12:53:03.434] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:03.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:54:0) after 1m0s
[12:54:03.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:54:0)
[12:54:03.732] Timer tick, asking Buildbucket for the build status
[12:54:03.965] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:03.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:55:0) after 1m0s
[12:55:04.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:55:0)
[12:55:04.053] Timer tick, asking Buildbucket for the build status
[12:55:04.158] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:04.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:56:0) after 1m0s
[12:56:04.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:56:0)
[12:56:04.386] Timer tick, asking Buildbucket for the build status
[12:56:04.528] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:04.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:57:0) after 1m0s
[12:57:04.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:57:0)
[12:57:04.550] Timer tick, asking Buildbucket for the build status
[12:57:04.724] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:04.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:58:0) after 1m0s
[12:58:04.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:58:0)
[12:58:04.724] Timer tick, asking Buildbucket for the build status
[12:58:05.013] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:05.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:59:0) after 1m0s
[12:59:05.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:59:0)
[12:59:05.156] Timer tick, asking Buildbucket for the build status
[12:59:05.398] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:05.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:60:0) after 1m0s
[13:00:05.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:60:0)
[13:00:05.450] Timer tick, asking Buildbucket for the build status
[13:00:05.551] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:05.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:61:0) after 1m0s
[13:01:05.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:61:0)
[13:01:05.588] Timer tick, asking Buildbucket for the build status
[13:01:05.685] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:05.685] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:62:0) after 1m0s
[13:02:05.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:62:0)
[13:02:05.713] Timer tick, asking Buildbucket for the build status
[13:02:05.940] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:05.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:63:0) after 1m0s
[13:03:05.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:63:0)
[13:03:05.956] Timer tick, asking Buildbucket for the build status
[13:03:06.058] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:06.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:64:0) after 1m0s
[13:04:06.140] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:64:0)
[13:04:06.141] Timer tick, asking Buildbucket for the build status
[13:04:06.223] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:06.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:65:0) after 1m0s
[13:05:06.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:65:0)
[13:05:06.214] Timer tick, asking Buildbucket for the build status
[13:05:06.302] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:06.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:66:0) after 1m0s
[13:06:06.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:66:0)
[13:06:06.346] Timer tick, asking Buildbucket for the build status
[13:06:06.566] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:06.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:67:0) after 1m0s
[13:07:06.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:67:0)
[13:07:06.647] Timer tick, asking Buildbucket for the build status
[13:07:06.758] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:06.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:68:0) after 1m0s
[13:08:06.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:68:0)
[13:08:06.786] Timer tick, asking Buildbucket for the build status
[13:08:06.858] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:06.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:69:0) after 1m0s
[13:09:06.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:69:0)
[13:09:06.934] Timer tick, asking Buildbucket for the build status
[13:09:07.049] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:07.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:70:0) after 1m0s
[13:10:07.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:70:0)
[13:10:07.075] Timer tick, asking Buildbucket for the build status
[13:10:07.252] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:07.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:71:0) after 1m0s
[13:11:07.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:71:0)
[13:11:07.277] Timer tick, asking Buildbucket for the build status
[13:11:07.358] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:07.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:72:0) after 1m0s
[13:12:07.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:72:0)
[13:12:07.405] Timer tick, asking Buildbucket for the build status
[13:12:09.411] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:09.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:73:0) after 1m0s
[13:13:09.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:73:0)
[13:13:09.448] Timer tick, asking Buildbucket for the build status
[13:13:09.517] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:09.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:74:0) after 1m0s
[13:14:09.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:74:0)
[13:14:09.617] Timer tick, asking Buildbucket for the build status
[13:14:09.798] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:09.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:75:0) after 1m0s
[13:15:09.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:75:0)
[13:15:09.837] Timer tick, asking Buildbucket for the build status
[13:15:10.558] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:10.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:76:0) after 1m0s
[13:16:10.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:76:0)
[13:16:10.617] Timer tick, asking Buildbucket for the build status
[13:16:10.693] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:10.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:77:0) after 1m0s
[13:17:10.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:77:0)
[13:17:10.748] Timer tick, asking Buildbucket for the build status
[13:17:10.927] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:10.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:78:0) after 1m0s
[13:18:11.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:78:0)
[13:18:11.002] Timer tick, asking Buildbucket for the build status
[13:18:11.229] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:11.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:79:0) after 1m0s
[13:19:11.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:79:0)
[13:19:11.293] Timer tick, asking Buildbucket for the build status
[13:19:11.428] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:11.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:80:0) after 1m0s
[13:20:11.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:80:0)
[13:20:11.478] Timer tick, asking Buildbucket for the build status
[13:20:11.643] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:11.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:81:0) after 1m0s
[13:21:11.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:81:0)
[13:21:11.712] Timer tick, asking Buildbucket for the build status
[13:21:11.799] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:11.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:82:0) after 1m0s
[13:22:11.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:82:0)
[13:22:11.879] Timer tick, asking Buildbucket for the build status
[13:22:11.998] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:11.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:83:0) after 1m0s
[13:23:12.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:83:0)
[13:23:12.052] Timer tick, asking Buildbucket for the build status
[13:23:12.163] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:12.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:84:0) after 1m0s
[13:24:12.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:84:0)
[13:24:12.231] Timer tick, asking Buildbucket for the build status
[13:24:12.485] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:12.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:85:0) after 1m0s
[13:25:12.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:85:0)
[13:25:12.831] Timer tick, asking Buildbucket for the build status
[13:25:12.999] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:12.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:86:0) after 1m0s
[13:26:13.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:86:0)
[13:26:13.037] Timer tick, asking Buildbucket for the build status
[13:26:13.163] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:13.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:87:0) after 1m0s
[13:27:13.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:87:0)
[13:27:13.279] Timer tick, asking Buildbucket for the build status
[13:27:13.562] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:13.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:88:0) after 1m0s
[13:28:13.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:88:0)
[13:28:13.667] Timer tick, asking Buildbucket for the build status
[13:28:13.762] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:13.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:89:0) after 1m0s
[13:29:13.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:89:0)
[13:29:13.882] Timer tick, asking Buildbucket for the build status
[13:29:13.979] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:13.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:90:0) after 1m0s
[13:30:14.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:90:0)
[13:30:14.068] Timer tick, asking Buildbucket for the build status
[13:30:14.147] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:14.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:91:0) after 1m0s
[13:31:14.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:91:0)
[13:31:14.469] Timer tick, asking Buildbucket for the build status
[13:31:14.736] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:14.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:92:0) after 1m0s
[13:32:14.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:92:0)
[13:32:14.824] Timer tick, asking Buildbucket for the build status
[13:32:15.238] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:15.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:93:0) after 1m0s
[13:33:15.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:93:0)
[13:33:15.461] Timer tick, asking Buildbucket for the build status
[13:33:15.722] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:15.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:94:0) after 1m0s
[13:34:15.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:94:0)
[13:34:15.783] Timer tick, asking Buildbucket for the build status
[13:34:15.872] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:15.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:95:0) after 1m0s
[13:35:15.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:95:0)
[13:35:15.918] Timer tick, asking Buildbucket for the build status
[13:35:15.977] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:15.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:96:0) after 1m0s
[13:36:16.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:96:0)
[13:36:16.064] Timer tick, asking Buildbucket for the build status
[13:36:16.132] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:16.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:97:0) after 1m0s
[13:37:16.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:97:0)
[13:37:16.197] Timer tick, asking Buildbucket for the build status
[13:37:16.483] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:16.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:98:0) after 1m0s
[13:38:16.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:98:0)
[13:38:16.599] Timer tick, asking Buildbucket for the build status
[13:38:16.708] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:16.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:99:0) after 1m0s
[13:39:16.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:99:0)
[13:39:16.809] Timer tick, asking Buildbucket for the build status
[13:39:16.874] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:16.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:100:0) after 1m0s
[13:40:16.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:100:0)
[13:40:16.958] Timer tick, asking Buildbucket for the build status
[13:40:17.065] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:17.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:101:0) after 1m0s
[13:41:17.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:101:0)
[13:41:17.168] Timer tick, asking Buildbucket for the build status
[13:41:17.346] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:17.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:102:0) after 1m0s
[13:42:17.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:102:0)
[13:42:17.521] Timer tick, asking Buildbucket for the build status
[13:42:17.829] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:17.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:103:0) after 1m0s
[13:43:17.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:103:0)
[13:43:17.966] Timer tick, asking Buildbucket for the build status
[13:43:18.059] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:18.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:104:0) after 1m0s
[13:44:18.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:104:0)
[13:44:18.098] Timer tick, asking Buildbucket for the build status
[13:44:18.190] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:18.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:105:0) after 1m0s
[13:45:18.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:105:0)
[13:45:18.251] Timer tick, asking Buildbucket for the build status
[13:45:18.346] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:18.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:106:0) after 1m0s
[13:46:18.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:106:0)
[13:46:18.388] Timer tick, asking Buildbucket for the build status
[13:46:18.573] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:18.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:107:0) after 1m0s
[13:47:18.630] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:107:0)
[13:47:18.630] Timer tick, asking Buildbucket for the build status
[13:47:18.799] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:18.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:108:0) after 1m0s
[13:48:18.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:108:0)
[13:48:18.852] Timer tick, asking Buildbucket for the build status
[13:48:18.978] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:18.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:109:0) after 1m0s
[13:49:19.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:109:0)
[13:49:19.011] Timer tick, asking Buildbucket for the build status
[13:49:19.072] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:19.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:110:0) after 1m0s
[13:50:19.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:110:0)
[13:50:19.118] Timer tick, asking Buildbucket for the build status
[13:50:19.278] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:19.278] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:111:0) after 1m0s
[13:51:19.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:111:0)
[13:51:19.343] Timer tick, asking Buildbucket for the build status
[13:51:19.410] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:19.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:112:0) after 1m0s
[13:52:19.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:112:0)
[13:52:19.494] Timer tick, asking Buildbucket for the build status
[13:52:19.665] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:19.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:113:0) after 1m0s
[13:53:19.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:113:0)
[13:53:19.720] Timer tick, asking Buildbucket for the build status
[13:53:19.787] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:19.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:114:0) after 1m0s
[13:54:19.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:114:0)
[13:54:19.893] Timer tick, asking Buildbucket for the build status
[13:54:20.866] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:20.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:115:0) after 1m0s
[13:55:21.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:115:0)
[13:55:21.533] Timer tick, asking Buildbucket for the build status
[13:55:21.663] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:21.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:116:0) after 1m0s
[13:56:21.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:116:0)
[13:56:21.900] Timer tick, asking Buildbucket for the build status
[13:56:21.985] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:21.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:117:0) after 1m0s
[13:57:22.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:117:0)
[13:57:22.044] Timer tick, asking Buildbucket for the build status
[13:57:22.384] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:22.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:118:0) after 1m0s
[13:58:22.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:118:0)
[13:58:22.503] Timer tick, asking Buildbucket for the build status
[13:58:22.616] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:22.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:119:0) after 1m0s
[13:59:22.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:119:0)
[13:59:22.752] Timer tick, asking Buildbucket for the build status
[13:59:23.082] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:23.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:120:0) after 1m0s
[14:00:24.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:120:0)
[14:00:24.255] Timer tick, asking Buildbucket for the build status
[14:00:24.319] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:24.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:121:0) after 1m0s
[14:01:24.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:121:0)
[14:01:24.366] Timer tick, asking Buildbucket for the build status
[14:01:24.634] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:24.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:122:0) after 1m0s
[14:02:24.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:122:0)
[14:02:24.698] Timer tick, asking Buildbucket for the build status
[14:02:24.819] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:24.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:123:0) after 1m0s
[14:03:24.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:123:0)
[14:03:24.883] Timer tick, asking Buildbucket for the build status
[14:03:24.957] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:24.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:124:0) after 1m0s
[14:04:25.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:124:0)
[14:04:25.062] Timer tick, asking Buildbucket for the build status
[14:04:25.182] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:25.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:125:0) after 1m0s
[14:05:25.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:125:0)
[14:05:25.274] Timer tick, asking Buildbucket for the build status
[14:05:25.551] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:25.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:126:0) after 1m0s
[14:06:25.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:126:0)
[14:06:25.529] Timer tick, asking Buildbucket for the build status
[14:06:25.641] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:25.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:127:0) after 1m0s
[14:07:25.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:127:0)
[14:07:25.726] Timer tick, asking Buildbucket for the build status
[14:07:25.965] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:25.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:128:0) after 1m0s
[14:08:26.030] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:128:0)
[14:08:26.030] Timer tick, asking Buildbucket for the build status
[14:08:26.134] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:26.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:129:0) after 1m0s
[14:09:26.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:129:0)
[14:09:26.163] Timer tick, asking Buildbucket for the build status
[14:09:26.353] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:26.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:130:0) after 1m0s
[14:10:26.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:130:0)
[14:10:26.512] Timer tick, asking Buildbucket for the build status
[14:10:26.613] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:26.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:131:0) after 1m0s
[14:11:26.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:131:0)
[14:11:26.633] Timer tick, asking Buildbucket for the build status
[14:11:26.984] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:26.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:132:0) after 1m0s
[14:12:27.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:132:0)
[14:12:27.000] Timer tick, asking Buildbucket for the build status
[14:12:27.115] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:27.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:133:0) after 1m0s
[14:13:27.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:133:0)
[14:13:27.160] Timer tick, asking Buildbucket for the build status
[14:13:27.460] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:27.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:134:0) after 1m0s
[14:14:27.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:134:0)
[14:14:27.481] Timer tick, asking Buildbucket for the build status
[14:14:27.546] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:27.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:135:0) after 1m0s
[14:15:27.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:135:0)
[14:15:27.565] Timer tick, asking Buildbucket for the build status
[14:15:27.660] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:27.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:136:0) after 1m0s
[14:16:27.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:136:0)
[14:16:27.651] Timer tick, asking Buildbucket for the build status
[14:16:27.868] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:27.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:137:0) after 1m0s
[14:17:28.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:137:0)
[14:17:28.477] Timer tick, asking Buildbucket for the build status
[14:17:28.659] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:28.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:138:0) after 1m0s
[14:18:28.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:138:0)
[14:18:28.791] Timer tick, asking Buildbucket for the build status
[14:18:28.878] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:28.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:139:0) after 1m0s
[14:19:28.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:139:0)
[14:19:28.994] Timer tick, asking Buildbucket for the build status
[14:19:29.145] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:29.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:140:0) after 1m0s
[14:20:29.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:140:0)
[14:20:29.301] Timer tick, asking Buildbucket for the build status
[14:20:29.459] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:29.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:141:0) after 1m0s
[14:21:29.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:141:0)
[14:21:29.499] Timer tick, asking Buildbucket for the build status
[14:21:29.583] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:29.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:142:0) after 1m0s
[14:22:29.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:142:0)
[14:22:29.679] Timer tick, asking Buildbucket for the build status
[14:22:29.864] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:29.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:143:0) after 1m0s
[14:23:30.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:143:0)
[14:23:30.158] Timer tick, asking Buildbucket for the build status
[14:23:30.264] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:30.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:144:0) after 1m0s
[14:24:30.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:144:0)
[14:24:30.388] Timer tick, asking Buildbucket for the build status
[14:24:30.809] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:30.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:145:0) after 1m0s
[14:25:30.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:145:0)
[14:25:30.972] Timer tick, asking Buildbucket for the build status
[14:25:31.057] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:31.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:146:0) after 1m0s
[14:26:31.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:146:0)
[14:26:31.059] Timer tick, asking Buildbucket for the build status
[14:26:31.191] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:31.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:147:0) after 1m0s
[14:27:31.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:147:0)
[14:27:31.317] Timer tick, asking Buildbucket for the build status
[14:27:31.749] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:31.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:148:0) after 1m0s
[14:28:31.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:148:0)
[14:28:31.904] Timer tick, asking Buildbucket for the build status
[14:28:32.107] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:32.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:149:0) after 1m0s
[14:29:32.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:149:0)
[14:29:32.183] Timer tick, asking Buildbucket for the build status
[14:29:32.257] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:32.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:150:0) after 1m0s
[14:30:32.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:150:0)
[14:30:32.357] Timer tick, asking Buildbucket for the build status
[14:30:32.447] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:32.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:151:0) after 1m0s
[14:31:32.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:151:0)
[14:31:32.510] Timer tick, asking Buildbucket for the build status
[14:31:32.769] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:32.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:152:0) after 1m0s
[14:32:32.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:152:0)
[14:32:32.833] Timer tick, asking Buildbucket for the build status
[14:32:33.025] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:33.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:153:0) after 1m0s
[14:33:33.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:153:0)
[14:33:33.094] Timer tick, asking Buildbucket for the build status
[14:33:33.395] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:33.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:154:0) after 1m0s
[14:34:33.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:154:0)
[14:34:33.545] Timer tick, asking Buildbucket for the build status
[14:34:33.631] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:33.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:155:0) after 1m0s
[14:35:33.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:155:0)
[14:35:33.649] Timer tick, asking Buildbucket for the build status
[14:35:33.748] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:33.748] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:156:0) after 1m0s
[14:36:33.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:156:0)
[14:36:33.809] Timer tick, asking Buildbucket for the build status
[14:36:34.430] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:34.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:157:0) after 1m0s
[14:37:34.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:157:0)
[14:37:34.849] Timer tick, asking Buildbucket for the build status
[14:37:35.016] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:35.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:158:0) after 1m0s
[14:38:35.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:158:0)
[14:38:35.254] Timer tick, asking Buildbucket for the build status
[14:38:35.320] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:35.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:159:0) after 1m0s
[14:39:35.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:159:0)
[14:39:35.483] Timer tick, asking Buildbucket for the build status
[14:39:35.562] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:35.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:160:0) after 1m0s
[14:40:35.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:160:0)
[14:40:35.666] Timer tick, asking Buildbucket for the build status
[14:40:35.741] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:35.741] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:161:0) after 1m0s
[14:41:35.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:161:0)
[14:41:35.797] Timer tick, asking Buildbucket for the build status
[14:41:36.075] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:36.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:162:0) after 1m0s
[14:42:36.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:162:0)
[14:42:36.219] Timer tick, asking Buildbucket for the build status
[14:42:36.387] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:36.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:163:0) after 1m0s
[14:43:36.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:163:0)
[14:43:36.507] Timer tick, asking Buildbucket for the build status
[14:43:36.573] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:36.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:164:0) after 1m0s
[14:44:37.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:164:0)
[14:44:37.783] Timer tick, asking Buildbucket for the build status
[14:44:38.095] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:38.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:165:0) after 1m0s
[14:45:38.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:165:0)
[14:45:38.158] Timer tick, asking Buildbucket for the build status
[14:45:38.418] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:38.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:166:0) after 1m0s
[14:46:38.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:166:0)
[14:46:38.701] Timer tick, asking Buildbucket for the build status
[14:46:38.915] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:38.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:167:0) after 1m0s
[14:47:39.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:167:0)
[14:47:39.021] Timer tick, asking Buildbucket for the build status
[14:47:39.145] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:39.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:168:0) after 1m0s
[14:48:39.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:168:0)
[14:48:39.362] Timer tick, asking Buildbucket for the build status
[14:48:39.588] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:39.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:169:0) after 1m0s
[14:49:39.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:169:0)
[14:49:39.729] Timer tick, asking Buildbucket for the build status
[14:49:40.023] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:40.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:170:0) after 1m0s
[14:50:40.081] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:170:0)
[14:50:40.081] Timer tick, asking Buildbucket for the build status
[14:50:40.361] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:40.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:171:0) after 1m0s
[14:51:40.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:171:0)
[14:51:40.551] Timer tick, asking Buildbucket for the build status
[14:51:40.749] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:40.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:172:0) after 1m0s
[14:52:40.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:172:0)
[14:52:40.994] Timer tick, asking Buildbucket for the build status
[14:52:41.197] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:41.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:173:0) after 1m0s
[14:53:41.326] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:173:0)
[14:53:41.326] Timer tick, asking Buildbucket for the build status
[14:53:41.511] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:41.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:174:0) after 1m0s
[14:54:41.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:174:0)
[14:54:41.681] Timer tick, asking Buildbucket for the build status
[14:54:41.782] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:41.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:175:0) after 1m0s
[14:55:41.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:175:0)
[14:55:41.811] Timer tick, asking Buildbucket for the build status
[14:55:41.883] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:41.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:176:0) after 1m0s
[14:56:41.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:176:0)
[14:56:41.973] Timer tick, asking Buildbucket for the build status
[14:56:42.091] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:42.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:177:0) after 1m0s
[14:57:42.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:177:0)
[14:57:42.264] Timer tick, asking Buildbucket for the build status
[14:57:42.419] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:42.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:178:0) after 1m0s
[14:58:42.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:178:0)
[14:58:42.569] Timer tick, asking Buildbucket for the build status
[14:58:42.647] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:42.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:179:0) after 1m0s
[14:59:42.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:179:0)
[14:59:42.744] Timer tick, asking Buildbucket for the build status
[14:59:42.871] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:42.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:180:0) after 1m0s
[15:00:42.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:180:0)
[15:00:42.906] Timer tick, asking Buildbucket for the build status
[15:00:43.792] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:43.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:181:0) after 1m0s
[15:01:43.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:181:0)
[15:01:43.831] Timer tick, asking Buildbucket for the build status
[15:01:44.541] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:44.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:182:0) after 1m0s
[15:02:44.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:182:0)
[15:02:44.608] Timer tick, asking Buildbucket for the build status
[15:02:44.811] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:44.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:183:0) after 1m0s
[15:03:44.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:183:0)
[15:03:44.852] Timer tick, asking Buildbucket for the build status
[15:03:45.029] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:45.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:184:0) after 1m0s
[15:04:45.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:184:0)
[15:04:45.089] Timer tick, asking Buildbucket for the build status
[15:04:45.166] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:45.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:185:0) after 1m0s
[15:05:45.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:185:0)
[15:05:45.187] Timer tick, asking Buildbucket for the build status
[15:05:45.524] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:45.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:186:0) after 1m0s
[15:06:45.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:186:0)
[15:06:45.621] Timer tick, asking Buildbucket for the build status
[15:06:45.712] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:45.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:187:0) after 1m0s
[15:07:45.706] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:187:0)
[15:07:45.706] Timer tick, asking Buildbucket for the build status
[15:07:45.831] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:45.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:188:0) after 1m0s
[15:08:45.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:188:0)
[15:08:45.851] Timer tick, asking Buildbucket for the build status
[15:08:45.985] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:45.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:189:0) after 1m0s
[15:09:46.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:189:0)
[15:09:46.052] Timer tick, asking Buildbucket for the build status
[15:09:46.141] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:46.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:190:0) after 1m0s
[15:10:46.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:190:0)
[15:10:46.251] Timer tick, asking Buildbucket for the build status
[15:10:46.315] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:46.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:191:0) after 1m0s
[15:11:46.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:191:0)
[15:11:46.446] Timer tick, asking Buildbucket for the build status
[15:11:46.532] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:46.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:192:0) after 1m0s
[15:12:46.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:192:0)
[15:12:46.592] Timer tick, asking Buildbucket for the build status
[15:12:47.702] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:47.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:193:0) after 1m0s
[15:13:47.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:193:0)
[15:13:47.806] Timer tick, asking Buildbucket for the build status
[15:13:47.906] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:47.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:194:0) after 1m0s
[15:14:47.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:194:0)
[15:14:47.975] Timer tick, asking Buildbucket for the build status
[15:14:48.391] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:48.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:195:0) after 1m0s
[15:15:48.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:195:0)
[15:15:48.416] Timer tick, asking Buildbucket for the build status
[15:15:48.677] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:48.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:196:0) after 1m0s
[15:16:48.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:196:0)
[15:16:48.737] Timer tick, asking Buildbucket for the build status
[15:16:48.844] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:48.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:197:0) after 1m0s
[15:17:48.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:197:0)
[15:17:48.958] Timer tick, asking Buildbucket for the build status
[15:17:49.400] Build 8873984724428079328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:49.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039414786644213440:198:0) after 1m0s
[15:18:13.446] Received PubSub notification, asking Buildbucket for the build status
[15:18:13.633] Build 8873984724428079328: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:18:13.633] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1595517492666263",
    "created_by": "project:infra",
    "created_ts": "1595505706339069",
    "id": "8873984724428079328",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4209.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"0ca31f48-f791-4a7a-8dbd-e6a227a89b54\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4209.2\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-rh7e\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5425-e4e3059\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1595505753454631",
    "status": "COMPLETED",
    "status_changed_ts": "1595517493117284",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9039414786644213440",
      "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/8873984724428079328/+/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:4d945e90cef4cb10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1595517493175852",
    "url": "https://ci.chromium.org/b/8873984724428079328",
    "utcnow_ts": "1595517493608340"
  }
}
[15:18:13.633] Invocation finished in 3h16m28.791157838s with status SUCCEEDED