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

• parent_buildername:publish_tarball
• user_agent:recipe

[02:56:25.061] New invocation is queued and will start shortly
[02:56:25.061] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[02:56:26.179] Starting the invocation (attempt 1)
[02:56:26.219] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:56:26.223] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:56:26.223] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9029211638639203744",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4323.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"61af277f-37f4-41db-97d4-672e293e94be\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4323.2\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9029211638639203744",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[02:56:27.137] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1605236186344311",
    "id": "8863781576626211568",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4323.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"61af277f-37f4-41db-97d4-672e293e94be\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4323.2\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1605236186877416",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9029211638639203744",
      "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/8863781576626211568/+/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": "1605236186877543",
    "url": "https://ci.chromium.org/b/8863781576626211568",
    "utcnow_ts": "1605236187124124"
  }
}
[02:56:27.137] Task URL: https://ci.chromium.org/b/8863781576626211568
[02:56:27.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:2:0) after 1m0s
[02:57:20.528] Received PubSub notification, asking Buildbucket for the build status
[02:57:21.768] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:27.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:2:0)
[02:57:27.173] Timer tick, asking Buildbucket for the build status
[02:57:27.254] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:27.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:4:0) after 1m0s
[02:58:27.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:4:0)
[02:58:27.262] Timer tick, asking Buildbucket for the build status
[02:58:27.345] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:27.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:5:0) after 1m0s
[02:59:27.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:5:0)
[02:59:27.386] Timer tick, asking Buildbucket for the build status
[02:59:27.678] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:27.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:6:0) after 1m0s
[03:00:27.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:6:0)
[03:00:27.689] Timer tick, asking Buildbucket for the build status
[03:00:27.803] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:27.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:7:0) after 1m0s
[03:01:27.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:7:0)
[03:01:27.931] Timer tick, asking Buildbucket for the build status
[03:01:28.016] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:28.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:8:0) after 1m0s
[03:02:28.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:8:0)
[03:02:28.083] Timer tick, asking Buildbucket for the build status
[03:02:28.788] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:28.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:9:0) after 1m0s
[03:03:30.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:9:0)
[03:03:30.900] Timer tick, asking Buildbucket for the build status
[03:03:31.007] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:31.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:10:0) after 1m0s
[03:04:31.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:10:0)
[03:04:31.070] Timer tick, asking Buildbucket for the build status
[03:04:31.413] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:31.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:11:0) after 1m0s
[03:05:31.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:11:0)
[03:05:31.417] Timer tick, asking Buildbucket for the build status
[03:05:31.498] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:31.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:12:0) after 1m0s
[03:06:31.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:12:0)
[03:06:31.534] Timer tick, asking Buildbucket for the build status
[03:06:31.757] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:31.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:13:0) after 1m0s
[03:07:31.799] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:13:0)
[03:07:31.799] Timer tick, asking Buildbucket for the build status
[03:07:32.073] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:32.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:14:0) after 1m0s
[03:08:32.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:14:0)
[03:08:32.284] Timer tick, asking Buildbucket for the build status
[03:08:32.367] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:32.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:15:0) after 1m0s
[03:09:32.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:15:0)
[03:09:32.440] Timer tick, asking Buildbucket for the build status
[03:09:32.526] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:32.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:16:0) after 1m0s
[03:10:32.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:16:0)
[03:10:32.537] Timer tick, asking Buildbucket for the build status
[03:10:32.633] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:32.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:17:0) after 1m0s
[03:11:32.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:17:0)
[03:11:32.641] Timer tick, asking Buildbucket for the build status
[03:11:32.742] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:32.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:18:0) after 1m0s
[03:12:32.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:18:0)
[03:12:32.776] Timer tick, asking Buildbucket for the build status
[03:12:33.035] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:33.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:19:0) after 1m0s
[03:13:33.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:19:0)
[03:13:33.066] Timer tick, asking Buildbucket for the build status
[03:13:33.217] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:33.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:20:0) after 1m0s
[03:14:33.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:20:0)
[03:14:33.262] Timer tick, asking Buildbucket for the build status
[03:14:33.541] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:33.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:21:0) after 1m0s
[03:15:33.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:21:0)
[03:15:33.581] Timer tick, asking Buildbucket for the build status
[03:15:33.986] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:33.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:22:0) after 1m0s
[03:16:34.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:22:0)
[03:16:34.034] Timer tick, asking Buildbucket for the build status
[03:16:34.186] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:34.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:23:0) after 1m0s
[03:17:34.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:23:0)
[03:17:34.232] Timer tick, asking Buildbucket for the build status
[03:17:34.342] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:34.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:24:0) after 1m0s
[03:18:34.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:24:0)
[03:18:34.376] Timer tick, asking Buildbucket for the build status
[03:18:34.480] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:34.480] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:25:0) after 1m0s
[03:19:34.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:25:0)
[03:19:34.568] Timer tick, asking Buildbucket for the build status
[03:19:34.763] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:34.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:26:0) after 1m0s
[03:20:34.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:26:0)
[03:20:34.814] Timer tick, asking Buildbucket for the build status
[03:20:34.928] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:34.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:27:0) after 1m0s
[03:21:34.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:27:0)
[03:21:34.948] Timer tick, asking Buildbucket for the build status
[03:21:35.364] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:35.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:28:0) after 1m0s
[03:22:35.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:28:0)
[03:22:35.403] Timer tick, asking Buildbucket for the build status
[03:22:35.503] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:35.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:29:0) after 1m0s
[03:23:35.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:29:0)
[03:23:35.493] Timer tick, asking Buildbucket for the build status
[03:23:35.624] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:35.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:30:0) after 1m0s
[03:24:35.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:30:0)
[03:24:35.654] Timer tick, asking Buildbucket for the build status
[03:24:35.771] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:35.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:31:0) after 1m0s
[03:25:35.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:31:0)
[03:25:35.800] Timer tick, asking Buildbucket for the build status
[03:25:35.921] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:35.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:32:0) after 1m0s
[03:26:35.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:32:0)
[03:26:35.954] Timer tick, asking Buildbucket for the build status
[03:26:36.104] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:36.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:33:0) after 1m0s
[03:27:36.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:33:0)
[03:27:36.131] Timer tick, asking Buildbucket for the build status
[03:27:36.255] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:36.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:34:0) after 1m0s
[03:28:36.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:34:0)
[03:28:36.284] Timer tick, asking Buildbucket for the build status
[03:28:36.396] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:36.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:35:0) after 1m0s
[03:29:36.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:35:0)
[03:29:36.448] Timer tick, asking Buildbucket for the build status
[03:29:36.773] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:36.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:36:0) after 1m0s
[03:30:36.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:36:0)
[03:30:36.756] Timer tick, asking Buildbucket for the build status
[03:30:36.900] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:36.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:37:0) after 1m0s
[03:31:37.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:37:0)
[03:31:37.036] Timer tick, asking Buildbucket for the build status
[03:31:37.198] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:37.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:38:0) after 1m0s
[03:32:37.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:38:0)
[03:32:37.208] Timer tick, asking Buildbucket for the build status
[03:32:38.357] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:38.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:39:0) after 1m0s
[03:33:38.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:39:0)
[03:33:38.430] Timer tick, asking Buildbucket for the build status
[03:33:38.622] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:38.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:40:0) after 1m0s
[03:34:38.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:40:0)
[03:34:38.689] Timer tick, asking Buildbucket for the build status
[03:34:38.915] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:38.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:41:0) after 1m0s
[03:35:38.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:41:0)
[03:35:38.967] Timer tick, asking Buildbucket for the build status
[03:35:39.204] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:39.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:42:0) after 1m0s
[03:36:39.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:42:0)
[03:36:39.247] Timer tick, asking Buildbucket for the build status
[03:36:39.423] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:39.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:43:0) after 1m0s
[03:37:39.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:43:0)
[03:37:39.444] Timer tick, asking Buildbucket for the build status
[03:37:39.893] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:39.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:44:0) after 1m0s
[03:38:39.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:44:0)
[03:38:39.909] Timer tick, asking Buildbucket for the build status
[03:38:40.177] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:40.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:45:0) after 1m0s
[03:39:40.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:45:0)
[03:39:40.252] Timer tick, asking Buildbucket for the build status
[03:39:40.395] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:40.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:46:0) after 1m0s
[03:40:40.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:46:0)
[03:40:40.422] Timer tick, asking Buildbucket for the build status
[03:40:40.539] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:40.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:47:0) after 1m0s
[03:41:40.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:47:0)
[03:41:40.575] Timer tick, asking Buildbucket for the build status
[03:41:40.829] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:40.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:48:0) after 1m0s
[03:42:40.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:48:0)
[03:42:40.858] Timer tick, asking Buildbucket for the build status
[03:42:41.204] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:41.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:49:0) after 1m0s
[03:43:41.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:49:0)
[03:43:41.230] Timer tick, asking Buildbucket for the build status
[03:43:41.431] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:41.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:50:0) after 1m0s
[03:44:41.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:50:0)
[03:44:41.477] Timer tick, asking Buildbucket for the build status
[03:44:41.563] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:41.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:51:0) after 1m0s
[03:45:41.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:51:0)
[03:45:41.590] Timer tick, asking Buildbucket for the build status
[03:45:41.732] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:41.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:52:0) after 1m0s
[03:46:41.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:52:0)
[03:46:41.777] Timer tick, asking Buildbucket for the build status
[03:46:42.603] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:42.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:53:0) after 1m0s
[03:47:42.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:53:0)
[03:47:42.623] Timer tick, asking Buildbucket for the build status
[03:47:42.729] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:42.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:54:0) after 1m0s
[03:48:42.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:54:0)
[03:48:42.752] Timer tick, asking Buildbucket for the build status
[03:48:42.847] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:42.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:55:0) after 1m0s
[03:49:42.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:55:0)
[03:49:42.936] Timer tick, asking Buildbucket for the build status
[03:49:43.044] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:43.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:56:0) after 1m0s
[03:50:43.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:56:0)
[03:50:43.187] Timer tick, asking Buildbucket for the build status
[03:50:43.294] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:43.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:57:0) after 1m0s
[03:51:43.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:57:0)
[03:51:43.382] Timer tick, asking Buildbucket for the build status
[03:51:43.521] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:43.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:58:0) after 1m0s
[03:52:43.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:58:0)
[03:52:43.629] Timer tick, asking Buildbucket for the build status
[03:52:43.721] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:43.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:59:0) after 1m0s
[03:53:43.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:59:0)
[03:53:43.753] Timer tick, asking Buildbucket for the build status
[03:53:43.851] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:43.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:60:0) after 1m0s
[03:54:43.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:60:0)
[03:54:43.899] Timer tick, asking Buildbucket for the build status
[03:54:44.194] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:44.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:61:0) after 1m0s
[03:55:44.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:61:0)
[03:55:44.271] Timer tick, asking Buildbucket for the build status
[03:55:44.426] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:44.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:62:0) after 1m0s
[03:56:44.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:62:0)
[03:56:44.483] Timer tick, asking Buildbucket for the build status
[03:56:44.648] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:44.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:63:0) after 1m0s
[03:57:44.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:63:0)
[03:57:44.720] Timer tick, asking Buildbucket for the build status
[03:57:44.817] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:44.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:64:0) after 1m0s
[03:58:44.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:64:0)
[03:58:44.859] Timer tick, asking Buildbucket for the build status
[03:58:46.253] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:46.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:65:0) after 1m0s
[03:59:46.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:65:0)
[03:59:46.364] Timer tick, asking Buildbucket for the build status
[03:59:46.450] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:46.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:66:0) after 1m0s
[04:00:46.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:66:0)
[04:00:46.512] Timer tick, asking Buildbucket for the build status
[04:00:46.803] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:46.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:67:0) after 1m0s
[04:01:46.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:67:0)
[04:01:46.886] Timer tick, asking Buildbucket for the build status
[04:01:47.017] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:47.017] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:68:0) after 1m0s
[04:02:47.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:68:0)
[04:02:47.176] Timer tick, asking Buildbucket for the build status
[04:02:47.267] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:47.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:69:0) after 1m0s
[04:03:47.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:69:0)
[04:03:47.440] Timer tick, asking Buildbucket for the build status
[04:03:47.525] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:47.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:70:0) after 1m0s
[04:04:47.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:70:0)
[04:04:47.755] Timer tick, asking Buildbucket for the build status
[04:04:47.858] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:47.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:71:0) after 1m0s
[04:05:48.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:71:0)
[04:05:48.178] Timer tick, asking Buildbucket for the build status
[04:05:48.254] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:48.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:72:0) after 1m0s
[04:06:48.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:72:0)
[04:06:48.370] Timer tick, asking Buildbucket for the build status
[04:06:48.808] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:48.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:73:0) after 1m0s
[04:07:48.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:73:0)
[04:07:48.816] Timer tick, asking Buildbucket for the build status
[04:07:48.931] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:48.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:74:0) after 1m0s
[04:08:49.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:74:0)
[04:08:49.034] Timer tick, asking Buildbucket for the build status
[04:08:49.334] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:49.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:75:0) after 1m0s
[04:09:49.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:75:0)
[04:09:49.420] Timer tick, asking Buildbucket for the build status
[04:09:49.677] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:49.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:76:0) after 1m0s
[04:10:49.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:76:0)
[04:10:49.731] Timer tick, asking Buildbucket for the build status
[04:10:50.295] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:50.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:77:0) after 1m0s
[04:11:50.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:77:0)
[04:11:50.317] Timer tick, asking Buildbucket for the build status
[04:11:50.488] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:50.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:78:0) after 1m0s
[04:12:50.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:78:0)
[04:12:50.576] Timer tick, asking Buildbucket for the build status
[04:12:51.228] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:51.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:79:0) after 1m0s
[04:13:51.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:79:0)
[04:13:51.305] Timer tick, asking Buildbucket for the build status
[04:13:51.441] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:51.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:80:0) after 1m0s
[04:14:51.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:80:0)
[04:14:51.580] Timer tick, asking Buildbucket for the build status
[04:14:51.808] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:51.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:81:0) after 1m0s
[04:15:51.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:81:0)
[04:15:51.840] Timer tick, asking Buildbucket for the build status
[04:15:52.164] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:52.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:82:0) after 1m0s
[04:16:52.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:82:0)
[04:16:52.212] Timer tick, asking Buildbucket for the build status
[04:16:52.957] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:52.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:83:0) after 1m0s
[04:17:53.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:83:0)
[04:17:53.032] Timer tick, asking Buildbucket for the build status
[04:17:53.133] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:53.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:84:0) after 1m0s
[04:18:53.229] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:84:0)
[04:18:53.229] Timer tick, asking Buildbucket for the build status
[04:18:53.553] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:53.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:85:0) after 1m0s
[04:19:53.598] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:85:0)
[04:19:53.598] Timer tick, asking Buildbucket for the build status
[04:19:54.029] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:54.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:86:0) after 1m0s
[04:20:54.072] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:86:0)
[04:20:54.072] Timer tick, asking Buildbucket for the build status
[04:20:55.557] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:55.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:87:0) after 1m0s
[04:21:55.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:87:0)
[04:21:55.628] Timer tick, asking Buildbucket for the build status
[04:21:55.979] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:55.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:88:0) after 1m0s
[04:22:56.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:88:0)
[04:22:56.069] Timer tick, asking Buildbucket for the build status
[04:22:56.169] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:56.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:89:0) after 1m0s
[04:23:56.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:89:0)
[04:23:56.373] Timer tick, asking Buildbucket for the build status
[04:23:56.577] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:56.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:90:0) after 1m0s
[04:24:56.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:90:0)
[04:24:56.633] Timer tick, asking Buildbucket for the build status
[04:24:56.994] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:56.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:91:0) after 1m0s
[04:25:57.040] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:91:0)
[04:25:57.040] Timer tick, asking Buildbucket for the build status
[04:25:57.116] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:57.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:92:0) after 1m0s
[04:26:57.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:92:0)
[04:26:57.164] Timer tick, asking Buildbucket for the build status
[04:26:57.495] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:57.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:93:0) after 1m0s
[04:27:57.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:93:0)
[04:27:57.536] Timer tick, asking Buildbucket for the build status
[04:27:57.714] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:57.714] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:94:0) after 1m0s
[04:28:57.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:94:0)
[04:28:57.825] Timer tick, asking Buildbucket for the build status
[04:28:57.955] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:57.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:95:0) after 1m0s
[04:29:57.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:95:0)
[04:29:57.989] Timer tick, asking Buildbucket for the build status
[04:29:58.158] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:58.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:96:0) after 1m0s
[04:30:58.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:96:0)
[04:30:58.182] Timer tick, asking Buildbucket for the build status
[04:30:58.331] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:58.331] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:97:0) after 1m0s
[04:31:58.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:97:0)
[04:31:58.371] Timer tick, asking Buildbucket for the build status
[04:31:58.543] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:58.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:98:0) after 1m0s
[04:32:58.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:98:0)
[04:32:58.603] Timer tick, asking Buildbucket for the build status
[04:32:58.716] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:58.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:99:0) after 1m0s
[04:33:58.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:99:0)
[04:33:58.747] Timer tick, asking Buildbucket for the build status
[04:33:58.844] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:58.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:100:0) after 1m0s
[04:34:58.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:100:0)
[04:34:58.902] Timer tick, asking Buildbucket for the build status
[04:34:58.988] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:58.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:101:0) after 1m0s
[04:35:59.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:101:0)
[04:35:59.068] Timer tick, asking Buildbucket for the build status
[04:35:59.225] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:59.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:102:0) after 1m0s
[04:36:59.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:102:0)
[04:36:59.259] Timer tick, asking Buildbucket for the build status
[04:36:59.476] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:59.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:103:0) after 1m0s
[04:37:59.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:103:0)
[04:37:59.536] Timer tick, asking Buildbucket for the build status
[04:37:59.726] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:59.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:104:0) after 1m0s
[04:38:59.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:104:0)
[04:38:59.804] Timer tick, asking Buildbucket for the build status
[04:38:59.914] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:59.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:105:0) after 1m0s
[04:39:59.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:105:0)
[04:39:59.979] Timer tick, asking Buildbucket for the build status
[04:40:00.311] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:00.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:106:0) after 1m0s
[04:41:00.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:106:0)
[04:41:00.302] Timer tick, asking Buildbucket for the build status
[04:41:00.395] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:00.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:107:0) after 1m0s
[04:42:00.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:107:0)
[04:42:00.525] Timer tick, asking Buildbucket for the build status
[04:42:01.950] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:01.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:108:0) after 1m0s
[04:43:02.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:108:0)
[04:43:02.508] Timer tick, asking Buildbucket for the build status
[04:43:02.928] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:02.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:109:0) after 1m0s
[04:44:02.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:109:0)
[04:44:02.947] Timer tick, asking Buildbucket for the build status
[04:44:03.053] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:03.053] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:110:0) after 1m0s
[04:45:03.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:110:0)
[04:45:03.276] Timer tick, asking Buildbucket for the build status
[04:45:07.065] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:07.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:111:0) after 1m0s
[04:46:07.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:111:0)
[04:46:07.191] Timer tick, asking Buildbucket for the build status
[04:46:07.297] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:07.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:112:0) after 1m0s
[04:47:07.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:112:0)
[04:47:07.383] Timer tick, asking Buildbucket for the build status
[04:47:08.042] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:08.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:113:0) after 1m0s
[04:48:08.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:113:0)
[04:48:08.124] Timer tick, asking Buildbucket for the build status
[04:48:08.204] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:08.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:114:0) after 1m0s
[04:49:08.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:114:0)
[04:49:08.311] Timer tick, asking Buildbucket for the build status
[04:49:08.480] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:08.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:115:0) after 1m0s
[04:50:08.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:115:0)
[04:50:08.525] Timer tick, asking Buildbucket for the build status
[04:50:08.622] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:08.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:116:0) after 1m0s
[04:51:08.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:116:0)
[04:51:08.609] Timer tick, asking Buildbucket for the build status
[04:51:11.735] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:11.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:117:0) after 1m0s
[04:52:11.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:117:0)
[04:52:11.753] Timer tick, asking Buildbucket for the build status
[04:52:12.586] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:12.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:118:0) after 1m0s
[04:53:12.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:118:0)
[04:53:12.666] Timer tick, asking Buildbucket for the build status
[04:53:12.751] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:12.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:119:0) after 1m0s
[04:54:12.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:119:0)
[04:54:12.757] Timer tick, asking Buildbucket for the build status
[04:54:12.862] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:12.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:120:0) after 1m0s
[04:55:12.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:120:0)
[04:55:12.884] Timer tick, asking Buildbucket for the build status
[04:55:13.023] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:13.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:121:0) after 1m0s
[04:56:13.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:121:0)
[04:56:13.117] Timer tick, asking Buildbucket for the build status
[04:56:13.259] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:13.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:122:0) after 1m0s
[04:57:13.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:122:0)
[04:57:13.435] Timer tick, asking Buildbucket for the build status
[04:57:13.748] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:13.748] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:123:0) after 1m0s
[04:58:13.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:123:0)
[04:58:13.960] Timer tick, asking Buildbucket for the build status
[04:58:14.083] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:14.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:124:0) after 1m0s
[04:59:14.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:124:0)
[04:59:14.209] Timer tick, asking Buildbucket for the build status
[04:59:14.277] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:14.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:125:0) after 1m0s
[05:00:14.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:125:0)
[05:00:14.315] Timer tick, asking Buildbucket for the build status
[05:00:15.156] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:15.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:126:0) after 1m0s
[05:01:15.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:126:0)
[05:01:15.255] Timer tick, asking Buildbucket for the build status
[05:01:15.715] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:15.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:127:0) after 1m0s
[05:02:15.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:127:0)
[05:02:15.753] Timer tick, asking Buildbucket for the build status
[05:02:15.911] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:15.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:128:0) after 1m0s
[05:03:16.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:128:0)
[05:03:16.026] Timer tick, asking Buildbucket for the build status
[05:03:16.125] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:16.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:129:0) after 1m0s
[05:04:16.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:129:0)
[05:04:16.317] Timer tick, asking Buildbucket for the build status
[05:04:16.516] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:16.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:130:0) after 1m0s
[05:05:16.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:130:0)
[05:05:16.641] Timer tick, asking Buildbucket for the build status
[05:05:16.760] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:16.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:131:0) after 1m0s
[05:06:16.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:131:0)
[05:06:16.750] Timer tick, asking Buildbucket for the build status
[05:06:16.893] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:16.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:132:0) after 1m0s
[05:07:16.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:132:0)
[05:07:16.916] Timer tick, asking Buildbucket for the build status
[05:07:17.137] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:17.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:133:0) after 1m0s
[05:08:17.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:133:0)
[05:08:17.308] Timer tick, asking Buildbucket for the build status
[05:08:17.408] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:17.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:134:0) after 1m0s
[05:09:17.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:134:0)
[05:09:17.627] Timer tick, asking Buildbucket for the build status
[05:09:17.740] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:17.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:135:0) after 1m0s
[05:10:17.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:135:0)
[05:10:17.849] Timer tick, asking Buildbucket for the build status
[05:10:17.998] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:17.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:136:0) after 1m0s
[05:11:18.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:136:0)
[05:11:18.085] Timer tick, asking Buildbucket for the build status
[05:11:18.203] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:18.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:137:0) after 1m0s
[05:12:18.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:137:0)
[05:12:18.338] Timer tick, asking Buildbucket for the build status
[05:12:18.624] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:18.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:138:0) after 1m0s
[05:13:18.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:138:0)
[05:13:18.751] Timer tick, asking Buildbucket for the build status
[05:13:18.843] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:18.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:139:0) after 1m0s
[05:14:19.019] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:139:0)
[05:14:19.019] Timer tick, asking Buildbucket for the build status
[05:14:20.661] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:20.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:140:0) after 1m0s
[05:15:20.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:140:0)
[05:15:20.971] Timer tick, asking Buildbucket for the build status
[05:15:21.066] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:21.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:141:0) after 1m0s
[05:16:21.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:141:0)
[05:16:21.210] Timer tick, asking Buildbucket for the build status
[05:16:21.304] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:21.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:142:0) after 1m0s
[05:17:21.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:142:0)
[05:17:21.485] Timer tick, asking Buildbucket for the build status
[05:17:21.680] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:21.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:143:0) after 1m0s
[05:18:21.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:143:0)
[05:18:21.816] Timer tick, asking Buildbucket for the build status
[05:18:21.903] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:21.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:144:0) after 1m0s
[05:19:21.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:144:0)
[05:19:21.931] Timer tick, asking Buildbucket for the build status
[05:19:22.058] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:22.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:145:0) after 1m0s
[05:20:22.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:145:0)
[05:20:22.187] Timer tick, asking Buildbucket for the build status
[05:20:22.496] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:22.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:146:0) after 1m0s
[05:21:22.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:146:0)
[05:21:22.557] Timer tick, asking Buildbucket for the build status
[05:21:22.652] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:22.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:147:0) after 1m0s
[05:22:22.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:147:0)
[05:22:22.746] Timer tick, asking Buildbucket for the build status
[05:22:23.154] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:23.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:148:0) after 1m0s
[05:23:23.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:148:0)
[05:23:23.251] Timer tick, asking Buildbucket for the build status
[05:23:23.336] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:23.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:149:0) after 1m0s
[05:24:23.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:149:0)
[05:24:23.369] Timer tick, asking Buildbucket for the build status
[05:24:23.451] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:23.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:150:0) after 1m0s
[05:25:23.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:150:0)
[05:25:23.550] Timer tick, asking Buildbucket for the build status
[05:25:23.650] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:23.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:151:0) after 1m0s
[05:26:23.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:151:0)
[05:26:23.705] Timer tick, asking Buildbucket for the build status
[05:26:23.835] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:23.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:152:0) after 1m0s
[05:27:23.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:152:0)
[05:27:23.911] Timer tick, asking Buildbucket for the build status
[05:27:24.093] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:24.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:153:0) after 1m0s
[05:28:24.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:153:0)
[05:28:24.123] Timer tick, asking Buildbucket for the build status
[05:28:24.276] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:24.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:154:0) after 1m0s
[05:29:24.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:154:0)
[05:29:24.341] Timer tick, asking Buildbucket for the build status
[05:29:24.432] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:24.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:155:0) after 1m0s
[05:30:24.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:155:0)
[05:30:24.489] Timer tick, asking Buildbucket for the build status
[05:30:24.591] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:24.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:156:0) after 1m0s
[05:31:24.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:156:0)
[05:31:24.626] Timer tick, asking Buildbucket for the build status
[05:31:26.225] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:26.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:157:0) after 1m0s
[05:32:26.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:157:0)
[05:32:26.321] Timer tick, asking Buildbucket for the build status
[05:32:26.506] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:26.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:158:0) after 1m0s
[05:33:26.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:158:0)
[05:33:26.539] Timer tick, asking Buildbucket for the build status
[05:33:26.620] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:26.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:159:0) after 1m0s
[05:34:26.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:159:0)
[05:34:26.719] Timer tick, asking Buildbucket for the build status
[05:34:26.952] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:26.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:160:0) after 1m0s
[05:35:26.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:160:0)
[05:35:26.965] Timer tick, asking Buildbucket for the build status
[05:35:27.071] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:27.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:161:0) after 1m0s
[05:36:27.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:161:0)
[05:36:27.104] Timer tick, asking Buildbucket for the build status
[05:36:27.307] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:27.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:162:0) after 1m0s
[05:37:27.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:162:0)
[05:37:27.377] Timer tick, asking Buildbucket for the build status
[05:37:27.552] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:27.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:163:0) after 1m0s
[05:38:27.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:163:0)
[05:38:27.635] Timer tick, asking Buildbucket for the build status
[05:38:27.982] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:27.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:164:0) after 1m0s
[05:39:28.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:164:0)
[05:39:28.031] Timer tick, asking Buildbucket for the build status
[05:39:28.115] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:28.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:165:0) after 1m0s
[05:40:28.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:165:0)
[05:40:28.149] Timer tick, asking Buildbucket for the build status
[05:40:28.239] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:28.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:166:0) after 1m0s
[05:41:28.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:166:0)
[05:41:28.357] Timer tick, asking Buildbucket for the build status
[05:41:28.680] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:28.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:167:0) after 1m0s
[05:42:28.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:167:0)
[05:42:28.803] Timer tick, asking Buildbucket for the build status
[05:42:28.998] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:28.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:168:0) after 1m0s
[05:43:29.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:168:0)
[05:43:29.112] Timer tick, asking Buildbucket for the build status
[05:43:29.204] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:29.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:169:0) after 1m0s
[05:44:29.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:169:0)
[05:44:29.278] Timer tick, asking Buildbucket for the build status
[05:44:29.421] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:29.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:170:0) after 1m0s
[05:45:29.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:170:0)
[05:45:29.537] Timer tick, asking Buildbucket for the build status
[05:45:29.646] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:29.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:171:0) after 1m0s
[05:46:29.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:171:0)
[05:46:29.690] Timer tick, asking Buildbucket for the build status
[05:46:29.783] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:29.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:172:0) after 1m0s
[05:47:29.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:172:0)
[05:47:29.815] Timer tick, asking Buildbucket for the build status
[05:47:30.096] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:30.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:173:0) after 1m0s
[05:48:30.171] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:173:0)
[05:48:30.171] Timer tick, asking Buildbucket for the build status
[05:48:30.704] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:30.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:174:0) after 1m0s
[05:49:30.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:174:0)
[05:49:30.861] Timer tick, asking Buildbucket for the build status
[05:49:30.932] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:30.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:175:0) after 1m0s
[05:50:30.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:175:0)
[05:50:30.992] Timer tick, asking Buildbucket for the build status
[05:50:31.112] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:31.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:176:0) after 1m0s
[05:51:31.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:176:0)
[05:51:31.106] Timer tick, asking Buildbucket for the build status
[05:51:31.347] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:31.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:177:0) after 1m0s
[05:52:31.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:177:0)
[05:52:31.475] Timer tick, asking Buildbucket for the build status
[05:52:31.647] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:31.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:178:0) after 1m0s
[05:53:31.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:178:0)
[05:53:31.732] Timer tick, asking Buildbucket for the build status
[05:53:32.299] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:32.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:179:0) after 1m0s
[05:54:32.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:179:0)
[05:54:32.347] Timer tick, asking Buildbucket for the build status
[05:54:32.478] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:32.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:180:0) after 1m0s
[05:55:32.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:180:0)
[05:55:32.477] Timer tick, asking Buildbucket for the build status
[05:55:32.562] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:32.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:181:0) after 1m0s
[05:56:32.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:181:0)
[05:56:32.610] Timer tick, asking Buildbucket for the build status
[05:56:32.694] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:32.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:182:0) after 1m0s
[05:57:32.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:182:0)
[05:57:32.768] Timer tick, asking Buildbucket for the build status
[05:57:32.864] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:32.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:183:0) after 1m0s
[05:58:32.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:183:0)
[05:58:32.974] Timer tick, asking Buildbucket for the build status
[05:58:33.098] Build 8863781576626211568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:33.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029211638639203744:184:0) after 1m0s
[05:59:04.818] Received PubSub notification, asking Buildbucket for the build status
[05:59:04.917] Build 8863781576626211568: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:59:04.917] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1605247143584865",
    "created_by": "project:infra",
    "created_ts": "1605236186344311",
    "id": "8863781576626211568",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4323.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"61af277f-37f4-41db-97d4-672e293e94be\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4323.2\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-jm3o\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1605236235311411",
    "status": "COMPLETED",
    "status_changed_ts": "1605247144443929",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9029211638639203744",
      "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/8863781576626211568/+/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:4fd859e971482210",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1605247144463308",
    "url": "https://ci.chromium.org/b/8863781576626211568",
    "utcnow_ts": "1605247144906601"
  }
}
[05:59:04.917] Invocation finished in 3h2m39.875805498s with status SUCCEEDED