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.4217.0"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[08:39:04.657] New invocation is queued and will start shortly
[08:39:04.657] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:39:05.827] Starting the invocation (attempt 1)
[08:39:05.872] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:39:05.872] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:39:05.872] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9038702761807873168",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4217.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"25343228-8a14-4cf3-89eb-9381076c7db7\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4217.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:9038702761807873168",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[08:39:06.464] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1596184745955620",
    "id": "8873272699783620320",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4217.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"25343228-8a14-4cf3-89eb-9381076c7db7\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4217.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1596184746163475",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038702761807873168",
      "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/8873272699783620320/+/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": "1596184746163600",
    "url": "https://ci.chromium.org/b/8873272699783620320",
    "utcnow_ts": "1596184746456933"
  }
}
[08:39:06.464] Task URL: https://ci.chromium.org/b/8873272699783620320
[08:39:06.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:2:0) after 1m0s
[08:39:56.777] Received PubSub notification, asking Buildbucket for the build status
[08:39:56.877] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:06.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:2:0)
[08:40:06.601] Timer tick, asking Buildbucket for the build status
[08:40:07.446] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:07.446] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:4:0) after 1m0s
[08:41:07.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:4:0)
[08:41:07.656] Timer tick, asking Buildbucket for the build status
[08:41:07.808] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:07.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:5:0) after 1m0s
[08:42:08.220] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:5:0)
[08:42:08.220] Timer tick, asking Buildbucket for the build status
[08:42:08.731] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:08.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:6:0) after 1m0s
[08:43:08.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:6:0)
[08:43:08.765] Timer tick, asking Buildbucket for the build status
[08:43:09.063] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:09.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:7:0) after 1m0s
[08:44:09.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:7:0)
[08:44:09.158] Timer tick, asking Buildbucket for the build status
[08:44:09.328] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:09.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:8:0) after 1m0s
[08:45:09.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:8:0)
[08:45:09.339] Timer tick, asking Buildbucket for the build status
[08:45:09.541] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:09.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:9:0) after 1m0s
[08:46:09.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:9:0)
[08:46:09.674] Timer tick, asking Buildbucket for the build status
[08:46:09.784] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:09.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:10:0) after 1m0s
[08:47:10.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:10:0)
[08:47:10.603] Timer tick, asking Buildbucket for the build status
[08:47:10.666] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:10.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:11:0) after 1m0s
[08:48:10.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:11:0)
[08:48:10.938] Timer tick, asking Buildbucket for the build status
[08:48:11.021] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:11.021] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:12:0) after 1m0s
[08:49:11.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:12:0)
[08:49:11.177] Timer tick, asking Buildbucket for the build status
[08:49:11.821] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:11.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:13:0) after 1m0s
[08:50:11.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:13:0)
[08:50:11.828] Timer tick, asking Buildbucket for the build status
[08:50:12.149] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:12.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:14:0) after 1m0s
[08:51:12.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:14:0)
[08:51:12.277] Timer tick, asking Buildbucket for the build status
[08:51:12.436] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:12.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:15:0) after 1m0s
[08:52:12.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:15:0)
[08:52:12.516] Timer tick, asking Buildbucket for the build status
[08:52:12.617] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:12.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:16:0) after 1m0s
[08:53:12.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:16:0)
[08:53:12.717] Timer tick, asking Buildbucket for the build status
[08:53:12.819] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:12.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:17:0) after 1m0s
[08:54:12.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:17:0)
[08:54:12.876] Timer tick, asking Buildbucket for the build status
[08:54:14.418] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:14.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:18:0) after 1m0s
[08:55:14.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:18:0)
[08:55:14.459] Timer tick, asking Buildbucket for the build status
[08:55:14.537] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:14.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:19:0) after 1m0s
[08:56:14.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:19:0)
[08:56:14.607] Timer tick, asking Buildbucket for the build status
[08:56:14.688] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:14.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:20:0) after 1m0s
[08:57:14.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:20:0)
[08:57:14.798] Timer tick, asking Buildbucket for the build status
[08:57:15.105] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:15.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:21:0) after 1m0s
[08:58:15.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:21:0)
[08:58:15.178] Timer tick, asking Buildbucket for the build status
[08:58:15.386] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:15.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:22:0) after 1m0s
[08:59:15.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:22:0)
[08:59:15.446] Timer tick, asking Buildbucket for the build status
[08:59:16.285] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:16.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:23:0) after 1m0s
[09:00:16.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:23:0)
[09:00:16.288] Timer tick, asking Buildbucket for the build status
[09:00:17.656] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:17.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:24:0) after 1m0s
[09:01:17.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:24:0)
[09:01:17.637] Timer tick, asking Buildbucket for the build status
[09:01:17.884] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:17.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:25:0) after 1m0s
[09:02:17.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:25:0)
[09:02:17.927] Timer tick, asking Buildbucket for the build status
[09:02:18.085] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:18.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:26:0) after 1m0s
[09:03:18.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:26:0)
[09:03:18.113] Timer tick, asking Buildbucket for the build status
[09:03:18.197] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:18.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:27:0) after 1m0s
[09:04:18.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:27:0)
[09:04:18.239] Timer tick, asking Buildbucket for the build status
[09:04:18.362] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:18.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:28:0) after 1m0s
[09:05:18.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:28:0)
[09:05:18.422] Timer tick, asking Buildbucket for the build status
[09:05:18.509] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:18.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:29:0) after 1m0s
[09:06:18.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:29:0)
[09:06:18.563] Timer tick, asking Buildbucket for the build status
[09:06:19.452] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:19.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:30:0) after 1m0s
[09:07:19.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:30:0)
[09:07:19.446] Timer tick, asking Buildbucket for the build status
[09:07:19.596] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:19.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:31:0) after 1m0s
[09:08:19.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:31:0)
[09:08:19.610] Timer tick, asking Buildbucket for the build status
[09:08:19.686] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:19.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:32:0) after 1m0s
[09:09:19.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:32:0)
[09:09:19.818] Timer tick, asking Buildbucket for the build status
[09:09:19.966] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:19.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:33:0) after 1m0s
[09:10:20.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:33:0)
[09:10:20.212] Timer tick, asking Buildbucket for the build status
[09:10:20.883] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:20.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:34:0) after 1m0s
[09:11:20.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:34:0)
[09:11:20.907] Timer tick, asking Buildbucket for the build status
[09:11:21.011] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:21.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:35:0) after 1m0s
[09:12:21.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:35:0)
[09:12:21.096] Timer tick, asking Buildbucket for the build status
[09:12:21.182] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:21.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:36:0) after 1m0s
[09:13:21.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:36:0)
[09:13:21.205] Timer tick, asking Buildbucket for the build status
[09:13:21.389] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:21.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:37:0) after 1m0s
[09:14:21.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:37:0)
[09:14:21.480] Timer tick, asking Buildbucket for the build status
[09:14:21.687] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:21.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:38:0) after 1m0s
[09:15:21.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:38:0)
[09:15:21.721] Timer tick, asking Buildbucket for the build status
[09:15:22.000] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:22.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:39:0) after 1m0s
[09:16:22.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:39:0)
[09:16:22.052] Timer tick, asking Buildbucket for the build status
[09:16:22.391] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:22.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:40:0) after 1m0s
[09:17:22.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:40:0)
[09:17:22.415] Timer tick, asking Buildbucket for the build status
[09:17:22.523] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:22.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:41:0) after 1m0s
[09:18:22.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:41:0)
[09:18:22.607] Timer tick, asking Buildbucket for the build status
[09:18:22.721] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:22.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:42:0) after 1m0s
[09:19:22.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:42:0)
[09:19:22.784] Timer tick, asking Buildbucket for the build status
[09:19:23.018] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:23.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:43:0) after 1m0s
[09:20:23.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:43:0)
[09:20:23.001] Timer tick, asking Buildbucket for the build status
[09:20:23.149] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:23.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:44:0) after 1m0s
[09:21:23.171] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:44:0)
[09:21:23.171] Timer tick, asking Buildbucket for the build status
[09:21:23.270] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:23.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:45:0) after 1m0s
[09:22:23.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:45:0)
[09:22:23.336] Timer tick, asking Buildbucket for the build status
[09:22:23.424] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:23.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:46:0) after 1m0s
[09:23:23.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:46:0)
[09:23:23.482] Timer tick, asking Buildbucket for the build status
[09:23:23.576] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:23.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:47:0) after 1m0s
[09:24:23.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:47:0)
[09:24:23.672] Timer tick, asking Buildbucket for the build status
[09:24:23.993] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:23.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:48:0) after 1m0s
[09:25:24.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:48:0)
[09:25:24.077] Timer tick, asking Buildbucket for the build status
[09:25:24.179] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:24.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:49:0) after 1m0s
[09:26:24.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:49:0)
[09:26:24.201] Timer tick, asking Buildbucket for the build status
[09:26:24.315] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:24.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:50:0) after 1m0s
[09:27:24.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:50:0)
[09:27:24.393] Timer tick, asking Buildbucket for the build status
[09:27:24.586] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:24.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:51:0) after 1m0s
[09:28:24.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:51:0)
[09:28:24.673] Timer tick, asking Buildbucket for the build status
[09:28:25.645] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:25.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:52:0) after 1m0s
[09:29:25.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:52:0)
[09:29:25.655] Timer tick, asking Buildbucket for the build status
[09:29:25.746] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:25.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:53:0) after 1m0s
[09:30:25.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:53:0)
[09:30:25.815] Timer tick, asking Buildbucket for the build status
[09:30:25.914] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:25.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:54:0) after 1m0s
[09:31:25.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:54:0)
[09:31:25.941] Timer tick, asking Buildbucket for the build status
[09:31:26.106] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:26.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:55:0) after 1m0s
[09:32:26.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:55:0)
[09:32:26.211] Timer tick, asking Buildbucket for the build status
[09:32:26.405] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:26.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:56:0) after 1m0s
[09:33:26.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:56:0)
[09:33:26.463] Timer tick, asking Buildbucket for the build status
[09:33:26.547] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:26.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:57:0) after 1m0s
[09:34:26.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:57:0)
[09:34:26.680] Timer tick, asking Buildbucket for the build status
[09:34:26.937] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:26.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:58:0) after 1m0s
[09:35:27.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:58:0)
[09:35:27.014] Timer tick, asking Buildbucket for the build status
[09:35:27.070] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:27.070] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:59:0) after 1m0s
[09:36:27.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:59:0)
[09:36:27.066] Timer tick, asking Buildbucket for the build status
[09:36:27.178] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:27.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:60:0) after 1m0s
[09:37:27.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:60:0)
[09:37:27.758] Timer tick, asking Buildbucket for the build status
[09:37:27.864] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:27.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:61:0) after 1m0s
[09:38:27.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:61:0)
[09:38:27.909] Timer tick, asking Buildbucket for the build status
[09:38:27.987] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:27.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:62:0) after 1m0s
[09:39:28.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:62:0)
[09:39:28.088] Timer tick, asking Buildbucket for the build status
[09:39:28.244] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:28.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:63:0) after 1m0s
[09:40:28.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:63:0)
[09:40:28.424] Timer tick, asking Buildbucket for the build status
[09:40:28.745] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:28.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:64:0) after 1m0s
[09:41:28.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:64:0)
[09:41:28.794] Timer tick, asking Buildbucket for the build status
[09:41:28.868] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:28.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:65:0) after 1m0s
[09:42:28.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:65:0)
[09:42:28.896] Timer tick, asking Buildbucket for the build status
[09:42:28.953] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:28.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:66:0) after 1m0s
[09:43:28.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:66:0)
[09:43:28.933] Timer tick, asking Buildbucket for the build status
[09:43:29.013] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:29.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:67:0) after 1m0s
[09:44:29.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:67:0)
[09:44:29.033] Timer tick, asking Buildbucket for the build status
[09:44:29.143] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:29.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:68:0) after 1m0s
[09:45:29.260] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:68:0)
[09:45:29.260] Timer tick, asking Buildbucket for the build status
[09:45:29.405] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:29.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:69:0) after 1m0s
[09:46:29.491] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:69:0)
[09:46:29.491] Timer tick, asking Buildbucket for the build status
[09:46:29.577] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:29.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:70:0) after 1m0s
[09:47:29.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:70:0)
[09:47:29.637] Timer tick, asking Buildbucket for the build status
[09:47:29.714] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:29.714] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:71:0) after 1m0s
[09:48:29.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:71:0)
[09:48:29.798] Timer tick, asking Buildbucket for the build status
[09:48:29.947] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:29.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:72:0) after 1m0s
[09:49:29.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:72:0)
[09:49:29.987] Timer tick, asking Buildbucket for the build status
[09:49:30.231] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:30.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:73:0) after 1m0s
[09:50:30.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:73:0)
[09:50:30.256] Timer tick, asking Buildbucket for the build status
[09:50:30.330] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:30.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:74:0) after 1m0s
[09:51:30.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:74:0)
[09:51:30.389] Timer tick, asking Buildbucket for the build status
[09:51:30.534] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:30.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:75:0) after 1m0s
[09:52:30.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:75:0)
[09:52:30.602] Timer tick, asking Buildbucket for the build status
[09:52:30.699] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:30.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:76:0) after 1m0s
[09:53:30.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:76:0)
[09:53:30.790] Timer tick, asking Buildbucket for the build status
[09:53:31.273] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:31.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:77:0) after 1m0s
[09:54:31.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:77:0)
[09:54:31.286] Timer tick, asking Buildbucket for the build status
[09:54:31.453] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:31.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:78:0) after 1m0s
[09:55:31.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:78:0)
[09:55:31.483] Timer tick, asking Buildbucket for the build status
[09:55:31.793] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:31.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:79:0) after 1m0s
[09:56:31.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:79:0)
[09:56:31.885] Timer tick, asking Buildbucket for the build status
[09:56:32.079] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:32.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:80:0) after 1m0s
[09:57:32.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:80:0)
[09:57:32.096] Timer tick, asking Buildbucket for the build status
[09:57:32.214] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:32.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:81:0) after 1m0s
[09:58:32.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:81:0)
[09:58:32.225] Timer tick, asking Buildbucket for the build status
[09:58:32.577] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:32.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:82:0) after 1m0s
[09:59:32.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:82:0)
[09:59:32.615] Timer tick, asking Buildbucket for the build status
[09:59:33.009] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:33.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:83:0) after 1m0s
[10:00:33.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:83:0)
[10:00:33.112] Timer tick, asking Buildbucket for the build status
[10:00:33.192] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:33.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:84:0) after 1m0s
[10:01:33.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:84:0)
[10:01:33.264] Timer tick, asking Buildbucket for the build status
[10:01:33.351] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:33.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:85:0) after 1m0s
[10:02:33.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:85:0)
[10:02:33.400] Timer tick, asking Buildbucket for the build status
[10:02:33.517] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:33.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:86:0) after 1m0s
[10:03:33.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:86:0)
[10:03:33.559] Timer tick, asking Buildbucket for the build status
[10:03:33.642] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:33.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:87:0) after 1m0s
[10:04:33.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:87:0)
[10:04:33.748] Timer tick, asking Buildbucket for the build status
[10:04:33.878] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:33.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:88:0) after 1m0s
[10:05:33.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:88:0)
[10:05:33.955] Timer tick, asking Buildbucket for the build status
[10:05:34.380] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:34.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:89:0) after 1m0s
[10:06:34.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:89:0)
[10:06:34.519] Timer tick, asking Buildbucket for the build status
[10:06:34.774] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:34.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:90:0) after 1m0s
[10:07:34.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:90:0)
[10:07:34.831] Timer tick, asking Buildbucket for the build status
[10:07:34.902] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:34.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:91:0) after 1m0s
[10:08:35.121] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:91:0)
[10:08:35.121] Timer tick, asking Buildbucket for the build status
[10:08:35.231] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:35.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:92:0) after 1m0s
[10:09:35.399] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:92:0)
[10:09:35.399] Timer tick, asking Buildbucket for the build status
[10:09:35.641] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:35.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:93:0) after 1m0s
[10:10:35.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:93:0)
[10:10:35.743] Timer tick, asking Buildbucket for the build status
[10:10:35.844] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:35.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:94:0) after 1m0s
[10:11:35.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:94:0)
[10:11:35.927] Timer tick, asking Buildbucket for the build status
[10:11:35.997] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:35.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:95:0) after 1m0s
[10:12:36.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:95:0)
[10:12:36.098] Timer tick, asking Buildbucket for the build status
[10:12:36.262] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:36.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:96:0) after 1m0s
[10:13:36.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:96:0)
[10:13:36.376] Timer tick, asking Buildbucket for the build status
[10:13:36.528] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:36.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:97:0) after 1m0s
[10:14:36.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:97:0)
[10:14:36.780] Timer tick, asking Buildbucket for the build status
[10:14:36.939] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:36.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:98:0) after 1m0s
[10:15:37.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:98:0)
[10:15:37.080] Timer tick, asking Buildbucket for the build status
[10:15:37.209] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:37.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:99:0) after 1m0s
[10:16:38.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:99:0)
[10:16:38.143] Timer tick, asking Buildbucket for the build status
[10:16:38.367] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:38.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:100:0) after 1m0s
[10:17:39.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:100:0)
[10:17:39.388] Timer tick, asking Buildbucket for the build status
[10:17:39.484] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:39.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:101:0) after 1m0s
[10:18:39.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:101:0)
[10:18:39.757] Timer tick, asking Buildbucket for the build status
[10:18:39.830] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:39.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:102:0) after 1m0s
[10:19:39.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:102:0)
[10:19:39.992] Timer tick, asking Buildbucket for the build status
[10:19:40.133] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:40.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:103:0) after 1m0s
[10:20:40.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:103:0)
[10:20:40.415] Timer tick, asking Buildbucket for the build status
[10:20:40.488] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:40.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:104:0) after 1m0s
[10:21:40.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:104:0)
[10:21:40.729] Timer tick, asking Buildbucket for the build status
[10:21:40.819] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:40.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:105:0) after 1m0s
[10:22:40.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:105:0)
[10:22:40.921] Timer tick, asking Buildbucket for the build status
[10:22:41.290] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:41.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:106:0) after 1m0s
[10:23:41.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:106:0)
[10:23:41.964] Timer tick, asking Buildbucket for the build status
[10:23:42.034] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:42.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:107:0) after 1m0s
[10:24:42.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:107:0)
[10:24:42.754] Timer tick, asking Buildbucket for the build status
[10:24:42.857] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:42.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:108:0) after 1m0s
[10:25:43.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:108:0)
[10:25:43.148] Timer tick, asking Buildbucket for the build status
[10:25:43.219] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:43.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:109:0) after 1m0s
[10:26:43.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:109:0)
[10:26:43.386] Timer tick, asking Buildbucket for the build status
[10:26:43.474] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:43.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:110:0) after 1m0s
[10:27:43.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:110:0)
[10:27:43.541] Timer tick, asking Buildbucket for the build status
[10:27:43.604] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:43.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:111:0) after 1m0s
[10:28:43.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:111:0)
[10:28:43.731] Timer tick, asking Buildbucket for the build status
[10:28:43.872] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:43.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:112:0) after 1m0s
[10:29:44.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:112:0)
[10:29:44.688] Timer tick, asking Buildbucket for the build status
[10:29:44.883] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:44.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:113:0) after 1m0s
[10:30:45.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:113:0)
[10:30:45.059] Timer tick, asking Buildbucket for the build status
[10:30:47.318] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:47.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:114:0) after 1m0s
[10:31:47.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:114:0)
[10:31:47.562] Timer tick, asking Buildbucket for the build status
[10:31:47.639] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:47.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:115:0) after 1m0s
[10:32:47.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:115:0)
[10:32:47.717] Timer tick, asking Buildbucket for the build status
[10:32:47.874] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:47.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:116:0) after 1m0s
[10:33:48.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:116:0)
[10:33:48.014] Timer tick, asking Buildbucket for the build status
[10:33:48.185] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:48.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:117:0) after 1m0s
[10:34:48.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:117:0)
[10:34:48.365] Timer tick, asking Buildbucket for the build status
[10:34:48.513] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:48.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:118:0) after 1m0s
[10:35:48.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:118:0)
[10:35:48.874] Timer tick, asking Buildbucket for the build status
[10:35:48.954] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:48.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:119:0) after 1m0s
[10:36:49.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:119:0)
[10:36:49.098] Timer tick, asking Buildbucket for the build status
[10:36:49.173] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:49.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:120:0) after 1m0s
[10:37:49.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:120:0)
[10:37:49.338] Timer tick, asking Buildbucket for the build status
[10:37:51.030] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:51.030] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:121:0) after 1m0s
[10:38:51.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:121:0)
[10:38:51.048] Timer tick, asking Buildbucket for the build status
[10:38:51.127] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:51.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:122:0) after 1m0s
[10:39:51.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:122:0)
[10:39:51.238] Timer tick, asking Buildbucket for the build status
[10:39:51.405] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:51.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:123:0) after 1m0s
[10:40:51.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:123:0)
[10:40:51.470] Timer tick, asking Buildbucket for the build status
[10:40:51.551] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:51.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:124:0) after 1m0s
[10:41:51.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:124:0)
[10:41:51.688] Timer tick, asking Buildbucket for the build status
[10:41:52.053] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:52.053] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:125:0) after 1m0s
[10:42:52.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:125:0)
[10:42:52.097] Timer tick, asking Buildbucket for the build status
[10:42:52.746] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:52.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:126:0) after 1m0s
[10:43:52.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:126:0)
[10:43:52.830] Timer tick, asking Buildbucket for the build status
[10:43:52.910] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:52.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:127:0) after 1m0s
[10:44:52.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:127:0)
[10:44:52.947] Timer tick, asking Buildbucket for the build status
[10:44:53.135] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:53.135] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:128:0) after 1m0s
[10:45:53.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:128:0)
[10:45:53.188] Timer tick, asking Buildbucket for the build status
[10:45:53.270] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:53.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:129:0) after 1m0s
[10:46:53.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:129:0)
[10:46:53.398] Timer tick, asking Buildbucket for the build status
[10:46:53.558] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:53.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:130:0) after 1m0s
[10:47:53.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:130:0)
[10:47:53.686] Timer tick, asking Buildbucket for the build status
[10:47:53.783] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:53.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:131:0) after 1m0s
[10:48:53.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:131:0)
[10:48:53.812] Timer tick, asking Buildbucket for the build status
[10:48:53.884] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:53.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:132:0) after 1m0s
[10:49:53.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:132:0)
[10:49:53.909] Timer tick, asking Buildbucket for the build status
[10:49:54.123] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:54.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:133:0) after 1m0s
[10:50:54.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:133:0)
[10:50:54.176] Timer tick, asking Buildbucket for the build status
[10:50:54.259] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:54.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:134:0) after 1m0s
[10:51:54.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:134:0)
[10:51:54.327] Timer tick, asking Buildbucket for the build status
[10:51:54.519] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:54.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:135:0) after 1m0s
[10:52:54.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:135:0)
[10:52:54.659] Timer tick, asking Buildbucket for the build status
[10:52:54.727] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:54.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:136:0) after 1m0s
[10:53:54.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:136:0)
[10:53:54.782] Timer tick, asking Buildbucket for the build status
[10:53:54.863] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:54.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:137:0) after 1m0s
[10:54:54.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:137:0)
[10:54:54.968] Timer tick, asking Buildbucket for the build status
[10:54:55.121] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:55.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:138:0) after 1m0s
[10:55:55.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:138:0)
[10:55:55.167] Timer tick, asking Buildbucket for the build status
[10:55:55.242] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:55.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:139:0) after 1m0s
[10:56:55.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:139:0)
[10:56:55.266] Timer tick, asking Buildbucket for the build status
[10:56:55.389] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:55.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:140:0) after 1m0s
[10:57:55.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:140:0)
[10:57:55.424] Timer tick, asking Buildbucket for the build status
[10:57:55.502] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:55.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:141:0) after 1m0s
[10:58:55.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:141:0)
[10:58:55.561] Timer tick, asking Buildbucket for the build status
[10:58:55.641] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:55.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:142:0) after 1m0s
[10:59:55.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:142:0)
[10:59:55.625] Timer tick, asking Buildbucket for the build status
[10:59:55.730] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:55.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:143:0) after 1m0s
[11:00:55.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:143:0)
[11:00:55.765] Timer tick, asking Buildbucket for the build status
[11:00:55.826] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:55.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:144:0) after 1m0s
[11:01:55.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:144:0)
[11:01:55.945] Timer tick, asking Buildbucket for the build status
[11:01:56.009] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:56.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:145:0) after 1m0s
[11:02:56.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:145:0)
[11:02:56.074] Timer tick, asking Buildbucket for the build status
[11:02:56.135] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:56.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:146:0) after 1m0s
[11:03:56.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:146:0)
[11:03:56.164] Timer tick, asking Buildbucket for the build status
[11:03:56.224] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:56.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:147:0) after 1m0s
[11:04:56.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:147:0)
[11:04:56.244] Timer tick, asking Buildbucket for the build status
[11:04:56.698] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:56.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:148:0) after 1m0s
[11:05:56.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:148:0)
[11:05:56.766] Timer tick, asking Buildbucket for the build status
[11:05:56.833] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:56.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:149:0) after 1m0s
[11:06:56.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:149:0)
[11:06:56.880] Timer tick, asking Buildbucket for the build status
[11:06:56.943] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:56.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:150:0) after 1m0s
[11:07:56.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:150:0)
[11:07:56.982] Timer tick, asking Buildbucket for the build status
[11:07:57.277] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:57.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:151:0) after 1m0s
[11:08:57.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:151:0)
[11:08:57.307] Timer tick, asking Buildbucket for the build status
[11:08:57.561] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:57.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:152:0) after 1m0s
[11:09:57.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:152:0)
[11:09:57.596] Timer tick, asking Buildbucket for the build status
[11:09:57.759] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:57.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:153:0) after 1m0s
[11:10:57.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:153:0)
[11:10:57.793] Timer tick, asking Buildbucket for the build status
[11:10:57.885] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:57.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:154:0) after 1m0s
[11:11:57.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:154:0)
[11:11:57.913] Timer tick, asking Buildbucket for the build status
[11:11:57.985] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:57.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:155:0) after 1m0s
[11:12:58.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:155:0)
[11:12:58.099] Timer tick, asking Buildbucket for the build status
[11:12:58.286] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:58.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:156:0) after 1m0s
[11:13:58.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:156:0)
[11:13:58.388] Timer tick, asking Buildbucket for the build status
[11:13:58.450] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:58.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:157:0) after 1m0s
[11:14:58.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:157:0)
[11:14:58.538] Timer tick, asking Buildbucket for the build status
[11:14:58.807] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:58.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:158:0) after 1m0s
[11:15:58.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:158:0)
[11:15:58.906] Timer tick, asking Buildbucket for the build status
[11:15:58.991] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:58.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:159:0) after 1m0s
[11:16:59.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:159:0)
[11:16:59.106] Timer tick, asking Buildbucket for the build status
[11:16:59.283] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:59.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:160:0) after 1m0s
[11:17:59.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:160:0)
[11:17:59.337] Timer tick, asking Buildbucket for the build status
[11:17:59.513] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:59.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:161:0) after 1m0s
[11:18:59.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:161:0)
[11:18:59.673] Timer tick, asking Buildbucket for the build status
[11:18:59.744] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:59.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:162:0) after 1m0s
[11:19:59.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:162:0)
[11:19:59.836] Timer tick, asking Buildbucket for the build status
[11:19:59.975] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:59.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:163:0) after 1m0s
[11:20:59.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:163:0)
[11:20:59.998] Timer tick, asking Buildbucket for the build status
[11:21:00.272] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:00.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:164:0) after 1m0s
[11:22:00.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:164:0)
[11:22:00.365] Timer tick, asking Buildbucket for the build status
[11:22:00.510] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:00.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:165:0) after 1m0s
[11:23:01.015] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:165:0)
[11:23:01.015] Timer tick, asking Buildbucket for the build status
[11:23:01.551] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:01.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:166:0) after 1m0s
[11:24:01.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:166:0)
[11:24:01.638] Timer tick, asking Buildbucket for the build status
[11:24:01.741] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:01.741] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:167:0) after 1m0s
[11:25:01.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:167:0)
[11:25:01.794] Timer tick, asking Buildbucket for the build status
[11:25:01.921] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:01.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:168:0) after 1m0s
[11:26:02.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:168:0)
[11:26:02.346] Timer tick, asking Buildbucket for the build status
[11:26:02.434] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:02.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:169:0) after 1m0s
[11:27:02.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:169:0)
[11:27:02.594] Timer tick, asking Buildbucket for the build status
[11:27:02.726] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:02.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:170:0) after 1m0s
[11:28:02.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:170:0)
[11:28:02.882] Timer tick, asking Buildbucket for the build status
[11:28:02.969] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:02.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:171:0) after 1m0s
[11:29:03.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:171:0)
[11:29:03.018] Timer tick, asking Buildbucket for the build status
[11:29:03.470] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:03.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:172:0) after 1m0s
[11:30:03.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:172:0)
[11:30:03.516] Timer tick, asking Buildbucket for the build status
[11:30:03.896] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:03.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:173:0) after 1m0s
[11:31:04.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:173:0)
[11:31:04.031] Timer tick, asking Buildbucket for the build status
[11:31:04.228] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:04.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:174:0) after 1m0s
[11:32:04.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:174:0)
[11:32:04.320] Timer tick, asking Buildbucket for the build status
[11:32:04.460] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:04.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:175:0) after 1m0s
[11:33:04.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:175:0)
[11:33:04.553] Timer tick, asking Buildbucket for the build status
[11:33:04.689] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:04.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:176:0) after 1m0s
[11:34:04.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:176:0)
[11:34:04.733] Timer tick, asking Buildbucket for the build status
[11:34:04.967] Build 8873272699783620320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:04.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038702761807873168:177:0) after 1m0s
[11:34:59.405] Received PubSub notification, asking Buildbucket for the build status
[11:35:00.667] Build 8873272699783620320: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:35:00.667] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1596195298629979",
    "created_by": "project:infra",
    "created_ts": "1596184745955620",
    "id": "8873272699783620320",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4217.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"25343228-8a14-4cf3-89eb-9381076c7db7\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4217.0\"}}",
    "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-2sqx\"], \"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\": [\"5436-adf7f8a\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1596184796151943",
    "status": "COMPLETED",
    "status_changed_ts": "1596195299061061",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038702761807873168",
      "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/8873272699783620320/+/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:4dbcd7e2529fe110",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1596195299099918",
    "url": "https://ci.chromium.org/b/8873272699783620320",
    "utcnow_ts": "1596195300656623"
  }
}
[11:35:00.667] Invocation finished in 2h55m56.02624771s with status SUCCEEDED