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

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

{
  "version": "83.0.4096.3"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[23:40:00.381] New invocation is queued and will start shortly
[23:40:00.381] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[23:40:01.727] Starting the invocation (attempt 1)
[23:40:01.773] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:40:01.773] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:40:01.773] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9050151895016322256",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"83.0.4096.3\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"e358c606-6127-4afe-8879-5a9e534fa82a\",\"title\":\"publish_tarball/0\"}]},\"version\":\"83.0.4096.3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9050151895016322256",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[23:40:02.427] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1585266001873906",
    "id": "8884721832778016944",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4096.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e358c606-6127-4afe-8879-5a9e534fa82a\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4096.3\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1585266002247090",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9050151895016322256",
      "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/8884721832778016944/+/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": "1585266002247248",
    "url": "https://ci.chromium.org/b/8884721832778016944",
    "utcnow_ts": "1585266002416306"
  }
}
[23:40:02.427] Task URL: https://ci.chromium.org/b/8884721832778016944
[23:40:02.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:2:0) after 1m0s
[23:41:02.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:2:0)
[23:41:02.454] Timer tick, asking Buildbucket for the build status
[23:41:02.754] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:02.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:3:0) after 1m0s
[23:42:02.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:3:0)
[23:42:02.815] Timer tick, asking Buildbucket for the build status
[23:42:03.267] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:03.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:4:0) after 1m0s
[23:43:03.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:4:0)
[23:43:03.291] Timer tick, asking Buildbucket for the build status
[23:43:03.749] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:03.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:5:0) after 1m0s
[23:44:03.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:5:0)
[23:44:03.847] Timer tick, asking Buildbucket for the build status
[23:44:04.122] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:04.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:6:0) after 1m0s
[23:45:04.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:6:0)
[23:45:04.144] Timer tick, asking Buildbucket for the build status
[23:45:04.385] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:04.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:7:0) after 1m0s
[23:46:04.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:7:0)
[23:46:04.454] Timer tick, asking Buildbucket for the build status
[23:46:04.828] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:04.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:8:0) after 1m0s
[23:47:04.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:8:0)
[23:47:04.848] Timer tick, asking Buildbucket for the build status
[23:47:05.027] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:05.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:9:0) after 1m0s
[23:48:05.050] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:9:0)
[23:48:05.050] Timer tick, asking Buildbucket for the build status
[23:48:05.294] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:05.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:10:0) after 1m0s
[23:49:05.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:10:0)
[23:49:05.321] Timer tick, asking Buildbucket for the build status
[23:49:05.615] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:05.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:11:0) after 1m0s
[23:50:05.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:11:0)
[23:50:05.875] Timer tick, asking Buildbucket for the build status
[23:50:07.256] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:07.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:12:0) after 1m0s
[23:51:07.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:12:0)
[23:51:07.311] Timer tick, asking Buildbucket for the build status
[23:51:07.607] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:07.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:13:0) after 1m0s
[23:52:07.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:13:0)
[23:52:07.627] Timer tick, asking Buildbucket for the build status
[23:52:07.737] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:07.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:14:0) after 1m0s
[23:53:07.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:14:0)
[23:53:07.752] Timer tick, asking Buildbucket for the build status
[23:53:07.893] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:07.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:15:0) after 1m0s
[23:54:07.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:15:0)
[23:54:07.949] Timer tick, asking Buildbucket for the build status
[23:54:08.091] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:08.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:16:0) after 1m0s
[23:55:08.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:16:0)
[23:55:08.117] Timer tick, asking Buildbucket for the build status
[23:55:09.890] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:09.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:17:0) after 1m0s
[23:56:09.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:17:0)
[23:56:09.948] Timer tick, asking Buildbucket for the build status
[23:56:10.399] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:10.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:18:0) after 1m0s
[23:57:10.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:18:0)
[23:57:10.462] Timer tick, asking Buildbucket for the build status
[23:57:12.704] Build 8884721832778016944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:12.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:19:0) after 1m0s
[23:57:26.533] Received PubSub notification, asking Buildbucket for the build status
[23:57:26.653] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:12.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:19:0)
[23:58:12.763] Timer tick, asking Buildbucket for the build status
[23:58:13.042] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:13.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:21:0) after 1m0s
[23:59:13.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:21:0)
[23:59:13.070] Timer tick, asking Buildbucket for the build status
[23:59:14.543] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:14.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:22:0) after 1m0s
[00:00:14.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:22:0)
[00:00:14.668] Timer tick, asking Buildbucket for the build status
[00:00:15.329] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:15.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:23:0) after 1m0s
[00:01:15.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:23:0)
[00:01:15.528] Timer tick, asking Buildbucket for the build status
[00:01:16.388] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:16.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:24:0) after 1m0s
[00:02:16.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:24:0)
[00:02:16.445] Timer tick, asking Buildbucket for the build status
[00:02:16.615] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:16.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:25:0) after 1m0s
[00:03:16.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:25:0)
[00:03:16.673] Timer tick, asking Buildbucket for the build status
[00:03:16.912] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:16.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:26:0) after 1m0s
[00:04:16.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:26:0)
[00:04:16.977] Timer tick, asking Buildbucket for the build status
[00:04:17.197] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:17.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:27:0) after 1m0s
[00:05:17.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:27:0)
[00:05:17.201] Timer tick, asking Buildbucket for the build status
[00:05:17.565] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:17.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:28:0) after 1m0s
[00:06:17.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:28:0)
[00:06:17.592] Timer tick, asking Buildbucket for the build status
[00:06:17.821] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:17.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:29:0) after 1m0s
[00:07:17.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:29:0)
[00:07:17.846] Timer tick, asking Buildbucket for the build status
[00:07:18.065] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:18.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:30:0) after 1m0s
[00:08:18.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:30:0)
[00:08:18.099] Timer tick, asking Buildbucket for the build status
[00:08:18.427] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:18.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:31:0) after 1m0s
[00:09:18.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:31:0)
[00:09:18.480] Timer tick, asking Buildbucket for the build status
[00:09:18.656] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:18.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:32:0) after 1m0s
[00:10:18.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:32:0)
[00:10:18.785] Timer tick, asking Buildbucket for the build status
[00:10:19.267] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:19.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:33:0) after 1m0s
[00:11:19.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:33:0)
[00:11:19.319] Timer tick, asking Buildbucket for the build status
[00:11:19.682] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:19.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:34:0) after 1m0s
[00:12:19.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:34:0)
[00:12:19.704] Timer tick, asking Buildbucket for the build status
[00:12:19.844] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:19.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:35:0) after 1m0s
[00:13:19.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:35:0)
[00:13:19.867] Timer tick, asking Buildbucket for the build status
[00:13:20.884] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:20.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:36:0) after 1m0s
[00:14:20.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:36:0)
[00:14:20.911] Timer tick, asking Buildbucket for the build status
[00:14:21.113] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:21.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:37:0) after 1m0s
[00:15:21.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:37:0)
[00:15:21.261] Timer tick, asking Buildbucket for the build status
[00:15:21.445] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:21.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:38:0) after 1m0s
[00:16:22.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:38:0)
[00:16:22.037] Timer tick, asking Buildbucket for the build status
[00:16:22.248] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:22.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:39:0) after 1m0s
[00:17:22.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:39:0)
[00:17:22.487] Timer tick, asking Buildbucket for the build status
[00:17:22.830] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:22.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:40:0) after 1m0s
[00:18:22.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:40:0)
[00:18:22.886] Timer tick, asking Buildbucket for the build status
[00:18:23.002] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:23.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:41:0) after 1m0s
[00:19:23.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:41:0)
[00:19:23.352] Timer tick, asking Buildbucket for the build status
[00:19:23.533] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:23.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:42:0) after 1m0s
[00:20:23.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:42:0)
[00:20:23.517] Timer tick, asking Buildbucket for the build status
[00:20:23.641] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:23.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:43:0) after 1m0s
[00:21:23.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:43:0)
[00:21:23.811] Timer tick, asking Buildbucket for the build status
[00:21:24.016] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:24.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:44:0) after 1m0s
[00:22:24.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:44:0)
[00:22:24.154] Timer tick, asking Buildbucket for the build status
[00:22:24.326] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:24.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:45:0) after 1m0s
[00:23:24.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:45:0)
[00:23:24.417] Timer tick, asking Buildbucket for the build status
[00:23:24.658] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:24.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:46:0) after 1m0s
[00:24:24.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:46:0)
[00:24:24.750] Timer tick, asking Buildbucket for the build status
[00:24:25.028] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:25.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:47:0) after 1m0s
[00:25:25.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:47:0)
[00:25:25.161] Timer tick, asking Buildbucket for the build status
[00:25:25.306] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:25.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:48:0) after 1m0s
[00:26:25.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:48:0)
[00:26:25.586] Timer tick, asking Buildbucket for the build status
[00:26:25.657] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:25.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:49:0) after 1m0s
[00:27:25.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:49:0)
[00:27:25.846] Timer tick, asking Buildbucket for the build status
[00:27:26.011] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:26.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:50:0) after 1m0s
[00:28:26.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:50:0)
[00:28:26.093] Timer tick, asking Buildbucket for the build status
[00:28:26.185] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:26.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:51:0) after 1m0s
[00:29:26.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:51:0)
[00:29:26.455] Timer tick, asking Buildbucket for the build status
[00:29:26.731] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:26.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:52:0) after 1m0s
[00:30:26.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:52:0)
[00:30:26.892] Timer tick, asking Buildbucket for the build status
[00:30:27.116] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:27.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:53:0) after 1m0s
[00:31:27.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:53:0)
[00:31:27.337] Timer tick, asking Buildbucket for the build status
[00:31:27.655] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:27.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:54:0) after 1m0s
[00:32:27.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:54:0)
[00:32:27.831] Timer tick, asking Buildbucket for the build status
[00:32:28.275] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:28.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:55:0) after 1m0s
[00:33:28.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:55:0)
[00:33:28.396] Timer tick, asking Buildbucket for the build status
[00:33:28.625] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:28.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:56:0) after 1m0s
[00:34:28.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:56:0)
[00:34:28.788] Timer tick, asking Buildbucket for the build status
[00:34:31.475] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:31.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:57:0) after 1m0s
[00:35:31.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:57:0)
[00:35:31.507] Timer tick, asking Buildbucket for the build status
[00:35:31.829] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:31.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:58:0) after 1m0s
[00:36:31.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:58:0)
[00:36:31.852] Timer tick, asking Buildbucket for the build status
[00:36:32.360] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:32.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:59:0) after 1m0s
[00:37:32.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:59:0)
[00:37:32.386] Timer tick, asking Buildbucket for the build status
[00:37:32.659] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:32.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:60:0) after 1m0s
[00:38:32.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:60:0)
[00:38:32.690] Timer tick, asking Buildbucket for the build status
[00:38:33.109] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:33.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:61:0) after 1m0s
[00:39:33.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:61:0)
[00:39:33.235] Timer tick, asking Buildbucket for the build status
[00:39:34.694] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:34.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:62:0) after 1m0s
[00:40:34.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:62:0)
[00:40:34.725] Timer tick, asking Buildbucket for the build status
[00:40:35.933] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:35.933] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:63:0) after 1m0s
[00:41:36.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:63:0)
[00:41:36.038] Timer tick, asking Buildbucket for the build status
[00:41:36.241] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:36.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:64:0) after 1m0s
[00:42:36.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:64:0)
[00:42:36.252] Timer tick, asking Buildbucket for the build status
[00:42:38.762] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:38.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:65:0) after 1m0s
[00:43:38.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:65:0)
[00:43:38.851] Timer tick, asking Buildbucket for the build status
[00:43:40.110] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:40.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:66:0) after 1m0s
[00:44:40.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:66:0)
[00:44:40.190] Timer tick, asking Buildbucket for the build status
[00:44:40.553] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:40.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:67:0) after 1m0s
[00:45:40.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:67:0)
[00:45:40.667] Timer tick, asking Buildbucket for the build status
[00:45:41.197] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:41.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:68:0) after 1m0s
[00:46:41.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:68:0)
[00:46:41.288] Timer tick, asking Buildbucket for the build status
[00:46:41.482] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:41.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:69:0) after 1m0s
[00:47:41.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:69:0)
[00:47:41.473] Timer tick, asking Buildbucket for the build status
[00:47:41.952] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:41.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:70:0) after 1m0s
[00:48:41.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:70:0)
[00:48:41.967] Timer tick, asking Buildbucket for the build status
[00:48:42.205] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:42.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:71:0) after 1m0s
[00:49:42.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:71:0)
[00:49:42.328] Timer tick, asking Buildbucket for the build status
[00:49:44.459] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:44.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:72:0) after 1m0s
[00:50:44.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:72:0)
[00:50:44.541] Timer tick, asking Buildbucket for the build status
[00:50:44.790] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:44.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:73:0) after 1m0s
[00:51:44.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:73:0)
[00:51:44.816] Timer tick, asking Buildbucket for the build status
[00:51:45.285] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:45.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:74:0) after 1m0s
[00:52:45.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:74:0)
[00:52:45.450] Timer tick, asking Buildbucket for the build status
[00:52:45.984] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:45.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:75:0) after 1m0s
[00:53:46.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:75:0)
[00:53:46.004] Timer tick, asking Buildbucket for the build status
[00:53:46.318] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:46.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:76:0) after 1m0s
[00:54:46.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:76:0)
[00:54:46.387] Timer tick, asking Buildbucket for the build status
[00:54:46.875] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:46.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:77:0) after 1m0s
[00:55:46.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:77:0)
[00:55:46.903] Timer tick, asking Buildbucket for the build status
[00:55:47.178] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:47.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:78:0) after 1m0s
[00:56:47.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:78:0)
[00:56:47.238] Timer tick, asking Buildbucket for the build status
[00:56:47.528] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:47.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:79:0) after 1m0s
[00:57:47.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:79:0)
[00:57:47.584] Timer tick, asking Buildbucket for the build status
[00:57:47.822] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:47.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:80:0) after 1m0s
[00:58:47.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:80:0)
[00:58:47.914] Timer tick, asking Buildbucket for the build status
[00:58:48.153] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:48.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:81:0) after 1m0s
[00:59:48.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:81:0)
[00:59:48.174] Timer tick, asking Buildbucket for the build status
[00:59:50.236] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:50.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:82:0) after 1m0s
[01:00:50.399] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:82:0)
[01:00:50.399] Timer tick, asking Buildbucket for the build status
[01:00:50.853] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:50.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:83:0) after 1m0s
[01:01:50.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:83:0)
[01:01:50.876] Timer tick, asking Buildbucket for the build status
[01:01:51.451] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:51.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:84:0) after 1m0s
[01:02:51.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:84:0)
[01:02:51.492] Timer tick, asking Buildbucket for the build status
[01:02:51.730] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:51.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:85:0) after 1m0s
[01:03:51.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:85:0)
[01:03:51.751] Timer tick, asking Buildbucket for the build status
[01:03:53.743] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:53.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:86:0) after 1m0s
[01:04:53.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:86:0)
[01:04:53.800] Timer tick, asking Buildbucket for the build status
[01:04:55.171] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:55.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:87:0) after 1m0s
[01:05:55.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:87:0)
[01:05:55.256] Timer tick, asking Buildbucket for the build status
[01:05:55.969] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:55.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:88:0) after 1m0s
[01:06:56.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:88:0)
[01:06:56.024] Timer tick, asking Buildbucket for the build status
[01:06:56.337] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:56.337] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:89:0) after 1m0s
[01:07:56.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:89:0)
[01:07:56.331] Timer tick, asking Buildbucket for the build status
[01:07:56.713] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:56.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:90:0) after 1m0s
[01:08:56.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:90:0)
[01:08:56.721] Timer tick, asking Buildbucket for the build status
[01:08:56.869] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:56.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:91:0) after 1m0s
[01:09:56.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:91:0)
[01:09:56.891] Timer tick, asking Buildbucket for the build status
[01:09:57.412] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:57.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:92:0) after 1m0s
[01:10:57.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:92:0)
[01:10:57.433] Timer tick, asking Buildbucket for the build status
[01:10:58.252] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:58.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:93:0) after 1m0s
[01:11:58.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:93:0)
[01:11:58.355] Timer tick, asking Buildbucket for the build status
[01:11:59.145] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:59.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:94:0) after 1m0s
[01:12:59.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:94:0)
[01:12:59.158] Timer tick, asking Buildbucket for the build status
[01:12:59.389] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:59.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:95:0) after 1m0s
[01:13:59.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:95:0)
[01:13:59.378] Timer tick, asking Buildbucket for the build status
[01:14:00.201] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:00.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:96:0) after 1m0s
[01:15:00.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:96:0)
[01:15:00.239] Timer tick, asking Buildbucket for the build status
[01:15:01.328] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:01.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:97:0) after 1m0s
[01:16:01.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:97:0)
[01:16:01.398] Timer tick, asking Buildbucket for the build status
[01:16:02.003] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:02.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:98:0) after 1m0s
[01:17:02.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:98:0)
[01:17:02.038] Timer tick, asking Buildbucket for the build status
[01:17:02.379] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:02.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:99:0) after 1m0s
[01:18:02.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:99:0)
[01:18:02.478] Timer tick, asking Buildbucket for the build status
[01:18:02.818] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:02.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:100:0) after 1m0s
[01:19:02.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:100:0)
[01:19:02.866] Timer tick, asking Buildbucket for the build status
[01:19:03.908] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:03.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:101:0) after 1m0s
[01:20:03.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:101:0)
[01:20:03.916] Timer tick, asking Buildbucket for the build status
[01:20:04.275] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:04.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:102:0) after 1m0s
[01:21:04.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:102:0)
[01:21:04.272] Timer tick, asking Buildbucket for the build status
[01:21:04.695] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:04.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:103:0) after 1m0s
[01:22:04.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:103:0)
[01:22:04.746] Timer tick, asking Buildbucket for the build status
[01:22:05.469] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:05.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:104:0) after 1m0s
[01:23:05.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:104:0)
[01:23:05.557] Timer tick, asking Buildbucket for the build status
[01:23:06.206] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:06.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:105:0) after 1m0s
[01:24:06.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:105:0)
[01:24:06.225] Timer tick, asking Buildbucket for the build status
[01:24:06.542] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:06.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:106:0) after 1m0s
[01:25:06.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:106:0)
[01:25:06.645] Timer tick, asking Buildbucket for the build status
[01:25:07.540] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:07.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:107:0) after 1m0s
[01:26:07.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:107:0)
[01:26:07.639] Timer tick, asking Buildbucket for the build status
[01:26:07.977] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:07.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:108:0) after 1m0s
[01:27:08.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:108:0)
[01:27:08.053] Timer tick, asking Buildbucket for the build status
[01:27:08.336] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:08.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:109:0) after 1m0s
[01:28:08.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:109:0)
[01:28:08.373] Timer tick, asking Buildbucket for the build status
[01:28:08.861] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:08.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:110:0) after 1m0s
[01:29:08.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:110:0)
[01:29:08.848] Timer tick, asking Buildbucket for the build status
[01:29:09.245] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:09.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:111:0) after 1m0s
[01:30:09.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:111:0)
[01:30:09.267] Timer tick, asking Buildbucket for the build status
[01:30:10.399] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:10.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:112:0) after 1m0s
[01:31:10.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:112:0)
[01:31:10.433] Timer tick, asking Buildbucket for the build status
[01:31:10.708] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:10.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:113:0) after 1m0s
[01:32:10.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:113:0)
[01:32:10.743] Timer tick, asking Buildbucket for the build status
[01:32:10.898] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:10.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:114:0) after 1m0s
[01:33:10.944] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:114:0)
[01:33:10.944] Timer tick, asking Buildbucket for the build status
[01:33:11.269] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:11.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:115:0) after 1m0s
[01:34:11.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:115:0)
[01:34:11.337] Timer tick, asking Buildbucket for the build status
[01:34:11.574] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:11.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:116:0) after 1m0s
[01:35:11.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:116:0)
[01:35:11.635] Timer tick, asking Buildbucket for the build status
[01:35:11.835] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:11.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:117:0) after 1m0s
[01:36:11.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:117:0)
[01:36:11.927] Timer tick, asking Buildbucket for the build status
[01:36:12.346] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:12.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:118:0) after 1m0s
[01:37:12.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:118:0)
[01:37:12.457] Timer tick, asking Buildbucket for the build status
[01:37:12.631] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:12.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:119:0) after 1m0s
[01:38:12.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:119:0)
[01:38:12.661] Timer tick, asking Buildbucket for the build status
[01:38:13.077] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:13.077] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:120:0) after 1m0s
[01:39:13.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:120:0)
[01:39:13.105] Timer tick, asking Buildbucket for the build status
[01:39:13.405] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:13.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:121:0) after 1m0s
[01:40:13.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:121:0)
[01:40:13.449] Timer tick, asking Buildbucket for the build status
[01:40:13.702] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:13.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:122:0) after 1m0s
[01:41:13.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:122:0)
[01:41:13.729] Timer tick, asking Buildbucket for the build status
[01:41:13.953] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:13.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:123:0) after 1m0s
[01:42:14.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:123:0)
[01:42:14.028] Timer tick, asking Buildbucket for the build status
[01:42:14.290] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:14.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:124:0) after 1m0s
[01:43:14.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:124:0)
[01:43:14.333] Timer tick, asking Buildbucket for the build status
[01:43:14.739] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:14.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:125:0) after 1m0s
[01:44:14.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:125:0)
[01:44:14.761] Timer tick, asking Buildbucket for the build status
[01:44:15.077] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:15.077] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:126:0) after 1m0s
[01:45:15.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:126:0)
[01:45:15.182] Timer tick, asking Buildbucket for the build status
[01:45:15.437] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:15.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:127:0) after 1m0s
[01:46:15.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:127:0)
[01:46:15.577] Timer tick, asking Buildbucket for the build status
[01:46:15.725] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:15.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:128:0) after 1m0s
[01:47:15.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:128:0)
[01:47:15.778] Timer tick, asking Buildbucket for the build status
[01:47:16.005] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:16.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:129:0) after 1m0s
[01:48:16.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:129:0)
[01:48:16.022] Timer tick, asking Buildbucket for the build status
[01:48:16.239] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:16.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:130:0) after 1m0s
[01:49:16.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:130:0)
[01:49:16.252] Timer tick, asking Buildbucket for the build status
[01:49:16.465] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:16.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:131:0) after 1m0s
[01:50:16.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:131:0)
[01:50:16.495] Timer tick, asking Buildbucket for the build status
[01:50:16.902] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:16.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:132:0) after 1m0s
[01:51:16.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:132:0)
[01:51:16.985] Timer tick, asking Buildbucket for the build status
[01:51:17.063] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:17.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:133:0) after 1m0s
[01:52:17.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:133:0)
[01:52:17.156] Timer tick, asking Buildbucket for the build status
[01:52:17.413] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:17.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:134:0) after 1m0s
[01:53:17.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:134:0)
[01:53:17.468] Timer tick, asking Buildbucket for the build status
[01:53:17.993] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:17.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:135:0) after 1m0s
[01:54:17.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:135:0)
[01:54:17.997] Timer tick, asking Buildbucket for the build status
[01:54:18.246] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:18.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:136:0) after 1m0s
[01:55:18.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:136:0)
[01:55:18.374] Timer tick, asking Buildbucket for the build status
[01:55:19.099] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:19.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:137:0) after 1m0s
[01:56:19.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:137:0)
[01:56:19.272] Timer tick, asking Buildbucket for the build status
[01:56:19.497] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:19.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:138:0) after 1m0s
[01:57:19.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:138:0)
[01:57:19.620] Timer tick, asking Buildbucket for the build status
[01:57:20.121] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:20.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:139:0) after 1m0s
[01:58:20.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:139:0)
[01:58:20.158] Timer tick, asking Buildbucket for the build status
[01:58:20.311] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:20.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:140:0) after 1m0s
[01:59:20.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:140:0)
[01:59:20.336] Timer tick, asking Buildbucket for the build status
[01:59:20.504] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:20.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:141:0) after 1m0s
[02:00:20.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:141:0)
[02:00:20.592] Timer tick, asking Buildbucket for the build status
[02:00:21.014] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:21.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:142:0) after 1m0s
[02:01:21.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:142:0)
[02:01:21.202] Timer tick, asking Buildbucket for the build status
[02:01:21.345] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:21.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:143:0) after 1m0s
[02:02:21.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:143:0)
[02:02:21.442] Timer tick, asking Buildbucket for the build status
[02:02:21.638] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:21.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:144:0) after 1m0s
[02:03:21.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:144:0)
[02:03:21.719] Timer tick, asking Buildbucket for the build status
[02:03:21.944] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:21.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:145:0) after 1m0s
[02:04:22.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:145:0)
[02:04:22.052] Timer tick, asking Buildbucket for the build status
[02:04:22.237] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:22.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:146:0) after 1m0s
[02:05:22.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:146:0)
[02:05:22.315] Timer tick, asking Buildbucket for the build status
[02:05:22.535] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:22.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:147:0) after 1m0s
[02:06:22.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:147:0)
[02:06:22.798] Timer tick, asking Buildbucket for the build status
[02:06:23.014] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:23.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:148:0) after 1m0s
[02:07:23.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:148:0)
[02:07:23.035] Timer tick, asking Buildbucket for the build status
[02:07:23.731] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:23.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:149:0) after 1m0s
[02:08:23.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:149:0)
[02:08:23.857] Timer tick, asking Buildbucket for the build status
[02:08:24.010] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:24.010] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:150:0) after 1m0s
[02:09:24.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:150:0)
[02:09:24.069] Timer tick, asking Buildbucket for the build status
[02:09:24.252] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:24.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:151:0) after 1m0s
[02:10:24.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:151:0)
[02:10:24.449] Timer tick, asking Buildbucket for the build status
[02:10:24.610] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:24.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:152:0) after 1m0s
[02:11:24.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:152:0)
[02:11:24.753] Timer tick, asking Buildbucket for the build status
[02:11:24.964] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:24.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:153:0) after 1m0s
[02:12:25.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:153:0)
[02:12:25.065] Timer tick, asking Buildbucket for the build status
[02:12:25.207] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:25.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:154:0) after 1m0s
[02:13:25.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:154:0)
[02:13:25.392] Timer tick, asking Buildbucket for the build status
[02:13:26.143] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:26.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:155:0) after 1m0s
[02:14:26.222] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:155:0)
[02:14:26.222] Timer tick, asking Buildbucket for the build status
[02:14:26.533] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:26.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:156:0) after 1m0s
[02:15:26.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:156:0)
[02:15:26.634] Timer tick, asking Buildbucket for the build status
[02:15:27.669] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:27.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:157:0) after 1m0s
[02:16:27.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:157:0)
[02:16:27.685] Timer tick, asking Buildbucket for the build status
[02:16:27.853] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:27.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:158:0) after 1m0s
[02:17:27.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:158:0)
[02:17:27.876] Timer tick, asking Buildbucket for the build status
[02:17:27.952] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:27.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:159:0) after 1m0s
[02:18:28.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:159:0)
[02:18:28.022] Timer tick, asking Buildbucket for the build status
[02:18:28.438] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:28.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:160:0) after 1m0s
[02:19:28.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:160:0)
[02:19:28.498] Timer tick, asking Buildbucket for the build status
[02:19:29.034] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:29.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:161:0) after 1m0s
[02:20:29.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:161:0)
[02:20:29.020] Timer tick, asking Buildbucket for the build status
[02:20:29.413] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:29.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:162:0) after 1m0s
[02:21:29.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:162:0)
[02:21:29.429] Timer tick, asking Buildbucket for the build status
[02:21:29.643] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:29.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:163:0) after 1m0s
[02:22:29.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:163:0)
[02:22:29.690] Timer tick, asking Buildbucket for the build status
[02:22:29.836] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:29.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:164:0) after 1m0s
[02:23:29.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:164:0)
[02:23:29.866] Timer tick, asking Buildbucket for the build status
[02:23:30.088] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:30.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:165:0) after 1m0s
[02:24:30.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:165:0)
[02:24:30.114] Timer tick, asking Buildbucket for the build status
[02:24:30.358] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:30.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:166:0) after 1m0s
[02:25:30.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:166:0)
[02:25:30.380] Timer tick, asking Buildbucket for the build status
[02:25:31.110] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:31.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:167:0) after 1m0s
[02:26:31.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:167:0)
[02:26:31.184] Timer tick, asking Buildbucket for the build status
[02:26:31.289] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:31.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:168:0) after 1m0s
[02:27:31.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:168:0)
[02:27:31.432] Timer tick, asking Buildbucket for the build status
[02:27:31.657] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:31.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:169:0) after 1m0s
[02:28:31.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:169:0)
[02:28:31.687] Timer tick, asking Buildbucket for the build status
[02:28:32.002] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:32.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:170:0) after 1m0s
[02:29:32.050] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:170:0)
[02:29:32.050] Timer tick, asking Buildbucket for the build status
[02:29:32.336] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:32.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:171:0) after 1m0s
[02:30:32.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:171:0)
[02:30:32.361] Timer tick, asking Buildbucket for the build status
[02:30:32.517] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:32.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:172:0) after 1m0s
[02:31:32.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:172:0)
[02:31:32.579] Timer tick, asking Buildbucket for the build status
[02:31:32.914] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:32.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:173:0) after 1m0s
[02:32:32.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:173:0)
[02:32:32.955] Timer tick, asking Buildbucket for the build status
[02:32:33.093] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:33.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:174:0) after 1m0s
[02:33:33.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:174:0)
[02:33:33.122] Timer tick, asking Buildbucket for the build status
[02:33:33.277] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:33.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:175:0) after 1m0s
[02:34:33.300] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:175:0)
[02:34:33.300] Timer tick, asking Buildbucket for the build status
[02:34:33.415] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:33.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:176:0) after 1m0s
[02:35:33.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:176:0)
[02:35:33.444] Timer tick, asking Buildbucket for the build status
[02:35:34.853] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:34.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:177:0) after 1m0s
[02:36:34.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:177:0)
[02:36:34.883] Timer tick, asking Buildbucket for the build status
[02:36:35.584] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:35.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:178:0) after 1m0s
[02:37:35.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:178:0)
[02:37:35.619] Timer tick, asking Buildbucket for the build status
[02:37:36.116] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:36.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:179:0) after 1m0s
[02:38:36.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:179:0)
[02:38:36.144] Timer tick, asking Buildbucket for the build status
[02:38:36.352] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:36.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:180:0) after 1m0s
[02:39:36.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:180:0)
[02:39:36.378] Timer tick, asking Buildbucket for the build status
[02:39:36.655] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:36.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:181:0) after 1m0s
[02:40:36.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:181:0)
[02:40:36.743] Timer tick, asking Buildbucket for the build status
[02:40:37.842] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:37.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:182:0) after 1m0s
[02:41:37.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:182:0)
[02:41:37.975] Timer tick, asking Buildbucket for the build status
[02:41:38.094] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:38.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:183:0) after 1m0s
[02:42:38.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:183:0)
[02:42:38.124] Timer tick, asking Buildbucket for the build status
[02:42:38.308] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:38.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:184:0) after 1m0s
[02:43:38.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:184:0)
[02:43:38.368] Timer tick, asking Buildbucket for the build status
[02:43:38.947] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:38.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:185:0) after 1m0s
[02:44:38.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:185:0)
[02:44:38.962] Timer tick, asking Buildbucket for the build status
[02:44:39.077] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:39.077] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:186:0) after 1m0s
[02:45:39.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:186:0)
[02:45:39.089] Timer tick, asking Buildbucket for the build status
[02:45:39.789] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:39.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:187:0) after 1m0s
[02:46:39.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:187:0)
[02:46:39.814] Timer tick, asking Buildbucket for the build status
[02:46:40.015] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:40.015] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:188:0) after 1m0s
[02:47:40.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:188:0)
[02:47:40.045] Timer tick, asking Buildbucket for the build status
[02:47:40.434] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:40.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:189:0) after 1m0s
[02:48:40.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:189:0)
[02:48:40.459] Timer tick, asking Buildbucket for the build status
[02:48:40.655] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:40.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:190:0) after 1m0s
[02:49:40.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:190:0)
[02:49:40.721] Timer tick, asking Buildbucket for the build status
[02:49:40.949] Build 8884721832778016944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:40.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050151895016322256:191:0) after 1m0s
[02:50:00.758] Received PubSub notification, asking Buildbucket for the build status
[02:50:00.861] Build 8884721832778016944: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:50:00.861] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1585277399729741",
    "created_by": "project:infra",
    "created_ts": "1585266001873906",
    "id": "8884721832778016944",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4096.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e358c606-6127-4afe-8879-5a9e534fa82a\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4096.3\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4096.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e358c606-6127-4afe-8879-5a9e534fa82a\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-pnkr\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"83.0.4096.3\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-pnkr\"], \"image\": [\"chrome-xenial-20032200-f0f7a76907a\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4895-ce889b2\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1585267045267680",
    "status": "COMPLETED",
    "status_changed_ts": "1585277400548211",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9050151895016322256",
      "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/8884721832778016944/+/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:4b32093cbf938d10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1585277400561971",
    "url": "https://ci.chromium.org/b/8884721832778016944",
    "utcnow_ts": "1585277400851430"
  }
}
[02:50:00.861] Invocation finished in 3h10m0.506480349s with status SUCCEEDED