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

• parent_buildername:publish_tarball
• user_agent:recipe

[11:01:00.181] New invocation is queued and will start shortly
[11:01:00.181] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[11:01:01.906] Starting the invocation (attempt 1)
[11:01:01.946] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:01:01.946] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:01:01.947] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9044492038483014224",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4158.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"ef2033f7-87db-46bb-a954-1ce8f88aa011\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4158.0\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9044492038483014224",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[11:01:02.632] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1590663662059574",
    "id": "8879061975851442864",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4158.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ef2033f7-87db-46bb-a954-1ce8f88aa011\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4158.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1590663662412886",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9044492038483014224",
      "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/8879061975851442864/+/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": "1590663662413056",
    "url": "https://ci.chromium.org/b/8879061975851442864",
    "utcnow_ts": "1590663662617980"
  }
}
[11:01:02.632] Task URL: https://ci.chromium.org/b/8879061975851442864
[11:01:02.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:2:0) after 1m0s
[11:02:02.354] Received PubSub notification, asking Buildbucket for the build status
[11:02:02.452] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:03.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:2:0)
[11:02:03.372] Timer tick, asking Buildbucket for the build status
[11:02:03.990] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:03.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:4:0) after 1m0s
[11:03:04.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:4:0)
[11:03:04.059] Timer tick, asking Buildbucket for the build status
[11:03:04.387] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:04.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:5:0) after 1m0s
[11:04:04.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:5:0)
[11:04:04.805] Timer tick, asking Buildbucket for the build status
[11:04:04.901] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:04.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:6:0) after 1m0s
[11:05:05.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:6:0)
[11:05:05.197] Timer tick, asking Buildbucket for the build status
[11:05:05.379] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:05.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:7:0) after 1m0s
[11:06:05.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:7:0)
[11:06:05.473] Timer tick, asking Buildbucket for the build status
[11:06:05.724] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:05.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:8:0) after 1m0s
[11:07:05.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:8:0)
[11:07:05.773] Timer tick, asking Buildbucket for the build status
[11:07:05.894] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:05.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:9:0) after 1m0s
[11:08:05.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:9:0)
[11:08:05.919] Timer tick, asking Buildbucket for the build status
[11:08:06.995] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:06.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:10:0) after 1m0s
[11:09:07.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:10:0)
[11:09:07.078] Timer tick, asking Buildbucket for the build status
[11:09:07.198] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:07.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:11:0) after 1m0s
[11:10:07.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:11:0)
[11:10:07.404] Timer tick, asking Buildbucket for the build status
[11:10:07.807] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:07.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:12:0) after 1m0s
[11:11:07.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:12:0)
[11:11:07.960] Timer tick, asking Buildbucket for the build status
[11:11:08.197] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:08.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:13:0) after 1m0s
[11:12:08.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:13:0)
[11:12:08.294] Timer tick, asking Buildbucket for the build status
[11:12:08.479] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:08.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:14:0) after 1m0s
[11:13:08.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:14:0)
[11:13:08.536] Timer tick, asking Buildbucket for the build status
[11:13:08.850] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:08.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:15:0) after 1m0s
[11:14:08.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:15:0)
[11:14:08.954] Timer tick, asking Buildbucket for the build status
[11:14:09.116] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:09.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:16:0) after 1m0s
[11:15:09.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:16:0)
[11:15:09.161] Timer tick, asking Buildbucket for the build status
[11:15:09.874] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:09.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:17:0) after 1m0s
[11:16:09.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:17:0)
[11:16:09.891] Timer tick, asking Buildbucket for the build status
[11:16:10.220] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:10.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:18:0) after 1m0s
[11:17:10.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:18:0)
[11:17:10.337] Timer tick, asking Buildbucket for the build status
[11:17:10.503] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:10.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:19:0) after 1m0s
[11:18:10.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:19:0)
[11:18:10.556] Timer tick, asking Buildbucket for the build status
[11:18:10.720] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:10.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:20:0) after 1m0s
[11:19:10.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:20:0)
[11:19:10.912] Timer tick, asking Buildbucket for the build status
[11:19:11.145] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:11.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:21:0) after 1m0s
[11:20:11.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:21:0)
[11:20:11.163] Timer tick, asking Buildbucket for the build status
[11:20:11.502] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:11.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:22:0) after 1m0s
[11:21:11.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:22:0)
[11:21:11.600] Timer tick, asking Buildbucket for the build status
[11:21:12.707] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:12.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:23:0) after 1m0s
[11:22:12.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:23:0)
[11:22:12.798] Timer tick, asking Buildbucket for the build status
[11:22:13.179] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:13.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:24:0) after 1m0s
[11:23:13.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:24:0)
[11:23:13.229] Timer tick, asking Buildbucket for the build status
[11:23:13.332] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:13.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:25:0) after 1m0s
[11:24:13.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:25:0)
[11:24:13.406] Timer tick, asking Buildbucket for the build status
[11:24:13.648] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:13.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:26:0) after 1m0s
[11:25:13.706] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:26:0)
[11:25:13.706] Timer tick, asking Buildbucket for the build status
[11:25:13.822] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:13.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:27:0) after 1m0s
[11:26:13.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:27:0)
[11:26:13.853] Timer tick, asking Buildbucket for the build status
[11:26:14.011] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:14.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:28:0) after 1m0s
[11:27:14.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:28:0)
[11:27:14.100] Timer tick, asking Buildbucket for the build status
[11:27:14.288] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:14.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:29:0) after 1m0s
[11:28:14.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:29:0)
[11:28:14.366] Timer tick, asking Buildbucket for the build status
[11:28:14.707] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:14.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:30:0) after 1m0s
[11:29:14.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:30:0)
[11:29:14.771] Timer tick, asking Buildbucket for the build status
[11:29:14.907] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:14.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:31:0) after 1m0s
[11:30:14.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:31:0)
[11:30:14.970] Timer tick, asking Buildbucket for the build status
[11:30:15.301] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:15.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:32:0) after 1m0s
[11:31:15.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:32:0)
[11:31:15.431] Timer tick, asking Buildbucket for the build status
[11:31:15.678] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:15.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:33:0) after 1m0s
[11:32:15.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:33:0)
[11:32:15.833] Timer tick, asking Buildbucket for the build status
[11:32:15.953] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:15.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:34:0) after 1m0s
[11:33:16.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:34:0)
[11:33:16.009] Timer tick, asking Buildbucket for the build status
[11:33:16.201] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:16.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:35:0) after 1m0s
[11:34:16.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:35:0)
[11:34:16.392] Timer tick, asking Buildbucket for the build status
[11:34:16.735] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:16.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:36:0) after 1m0s
[11:35:17.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:36:0)
[11:35:17.807] Timer tick, asking Buildbucket for the build status
[11:35:18.153] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:18.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:37:0) after 1m0s
[11:36:18.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:37:0)
[11:36:18.420] Timer tick, asking Buildbucket for the build status
[11:36:18.889] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:18.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:38:0) after 1m0s
[11:37:19.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:38:0)
[11:37:19.042] Timer tick, asking Buildbucket for the build status
[11:37:19.199] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:19.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:39:0) after 1m0s
[11:38:19.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:39:0)
[11:38:19.356] Timer tick, asking Buildbucket for the build status
[11:38:19.486] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:19.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:40:0) after 1m0s
[11:39:19.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:40:0)
[11:39:19.645] Timer tick, asking Buildbucket for the build status
[11:39:19.779] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:19.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:41:0) after 1m0s
[11:40:20.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:41:0)
[11:40:20.035] Timer tick, asking Buildbucket for the build status
[11:40:20.167] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:20.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:42:0) after 1m0s
[11:41:20.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:42:0)
[11:41:20.386] Timer tick, asking Buildbucket for the build status
[11:41:20.559] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:20.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:43:0) after 1m0s
[11:42:20.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:43:0)
[11:42:20.645] Timer tick, asking Buildbucket for the build status
[11:42:20.801] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:20.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:44:0) after 1m0s
[11:43:21.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:44:0)
[11:43:21.048] Timer tick, asking Buildbucket for the build status
[11:43:21.292] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:21.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:45:0) after 1m0s
[11:44:21.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:45:0)
[11:44:21.395] Timer tick, asking Buildbucket for the build status
[11:44:21.768] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:21.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:46:0) after 1m0s
[11:45:21.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:46:0)
[11:45:21.874] Timer tick, asking Buildbucket for the build status
[11:45:22.743] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:22.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:47:0) after 1m0s
[11:46:22.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:47:0)
[11:46:22.971] Timer tick, asking Buildbucket for the build status
[11:46:23.096] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:23.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:48:0) after 1m0s
[11:47:23.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:48:0)
[11:47:23.123] Timer tick, asking Buildbucket for the build status
[11:47:23.239] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:23.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:49:0) after 1m0s
[11:48:23.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:49:0)
[11:48:23.335] Timer tick, asking Buildbucket for the build status
[11:48:23.495] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:23.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:50:0) after 1m0s
[11:49:23.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:50:0)
[11:49:23.570] Timer tick, asking Buildbucket for the build status
[11:49:23.807] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:23.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:51:0) after 1m0s
[11:50:23.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:51:0)
[11:50:23.917] Timer tick, asking Buildbucket for the build status
[11:50:24.116] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:24.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:52:0) after 1m0s
[11:51:24.140] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:52:0)
[11:51:24.140] Timer tick, asking Buildbucket for the build status
[11:51:24.498] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:24.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:53:0) after 1m0s
[11:52:24.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:53:0)
[11:52:24.520] Timer tick, asking Buildbucket for the build status
[11:52:24.893] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:24.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:54:0) after 1m0s
[11:53:24.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:54:0)
[11:53:24.977] Timer tick, asking Buildbucket for the build status
[11:53:25.119] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:25.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:55:0) after 1m0s
[11:54:25.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:55:0)
[11:54:25.232] Timer tick, asking Buildbucket for the build status
[11:54:25.613] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:25.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:56:0) after 1m0s
[11:55:25.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:56:0)
[11:55:25.691] Timer tick, asking Buildbucket for the build status
[11:55:25.797] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:25.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:57:0) after 1m0s
[11:56:25.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:57:0)
[11:56:25.891] Timer tick, asking Buildbucket for the build status
[11:56:26.086] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:26.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:58:0) after 1m0s
[11:57:26.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:58:0)
[11:57:26.148] Timer tick, asking Buildbucket for the build status
[11:57:26.490] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:26.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:59:0) after 1m0s
[11:58:26.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:59:0)
[11:58:26.563] Timer tick, asking Buildbucket for the build status
[11:58:26.709] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:26.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:60:0) after 1m0s
[11:59:26.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:60:0)
[11:59:26.739] Timer tick, asking Buildbucket for the build status
[11:59:26.951] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:26.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:61:0) after 1m0s
[12:00:27.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:61:0)
[12:00:27.097] Timer tick, asking Buildbucket for the build status
[12:00:27.366] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:27.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:62:0) after 1m0s
[12:01:27.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:62:0)
[12:01:27.473] Timer tick, asking Buildbucket for the build status
[12:01:27.650] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:27.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:63:0) after 1m0s
[12:02:27.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:63:0)
[12:02:27.664] Timer tick, asking Buildbucket for the build status
[12:02:28.299] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:28.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:64:0) after 1m0s
[12:03:28.443] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:64:0)
[12:03:28.443] Timer tick, asking Buildbucket for the build status
[12:03:28.613] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:28.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:65:0) after 1m0s
[12:04:28.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:65:0)
[12:04:28.739] Timer tick, asking Buildbucket for the build status
[12:04:28.876] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:28.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:66:0) after 1m0s
[12:05:28.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:66:0)
[12:05:28.908] Timer tick, asking Buildbucket for the build status
[12:05:29.222] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:29.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:67:0) after 1m0s
[12:06:29.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:67:0)
[12:06:29.235] Timer tick, asking Buildbucket for the build status
[12:06:29.400] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:29.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:68:0) after 1m0s
[12:07:29.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:68:0)
[12:07:29.489] Timer tick, asking Buildbucket for the build status
[12:07:29.634] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:29.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:69:0) after 1m0s
[12:08:29.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:69:0)
[12:08:29.651] Timer tick, asking Buildbucket for the build status
[12:08:29.826] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:29.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:70:0) after 1m0s
[12:09:29.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:70:0)
[12:09:29.848] Timer tick, asking Buildbucket for the build status
[12:09:30.084] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:30.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:71:0) after 1m0s
[12:10:30.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:71:0)
[12:10:30.131] Timer tick, asking Buildbucket for the build status
[12:10:30.444] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:30.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:72:0) after 1m0s
[12:11:30.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:72:0)
[12:11:30.466] Timer tick, asking Buildbucket for the build status
[12:11:31.099] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:31.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:73:0) after 1m0s
[12:12:31.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:73:0)
[12:12:31.104] Timer tick, asking Buildbucket for the build status
[12:12:32.431] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:32.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:74:0) after 1m0s
[12:13:32.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:74:0)
[12:13:32.569] Timer tick, asking Buildbucket for the build status
[12:13:32.716] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:32.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:75:0) after 1m0s
[12:14:32.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:75:0)
[12:14:32.753] Timer tick, asking Buildbucket for the build status
[12:14:32.882] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:32.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:76:0) after 1m0s
[12:15:32.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:76:0)
[12:15:32.938] Timer tick, asking Buildbucket for the build status
[12:15:33.163] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:33.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:77:0) after 1m0s
[12:16:33.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:77:0)
[12:16:33.248] Timer tick, asking Buildbucket for the build status
[12:16:33.376] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:33.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:78:0) after 1m0s
[12:17:33.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:78:0)
[12:17:33.400] Timer tick, asking Buildbucket for the build status
[12:17:35.255] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:35.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:79:0) after 1m0s
[12:18:35.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:79:0)
[12:18:35.288] Timer tick, asking Buildbucket for the build status
[12:18:35.378] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:35.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:80:0) after 1m0s
[12:19:35.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:80:0)
[12:19:35.412] Timer tick, asking Buildbucket for the build status
[12:19:35.794] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:35.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:81:0) after 1m0s
[12:20:35.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:81:0)
[12:20:35.894] Timer tick, asking Buildbucket for the build status
[12:20:36.104] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:36.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:82:0) after 1m0s
[12:21:36.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:82:0)
[12:21:36.194] Timer tick, asking Buildbucket for the build status
[12:21:36.385] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:36.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:83:0) after 1m0s
[12:22:36.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:83:0)
[12:22:36.486] Timer tick, asking Buildbucket for the build status
[12:22:37.151] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:37.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:84:0) after 1m0s
[12:23:37.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:84:0)
[12:23:37.139] Timer tick, asking Buildbucket for the build status
[12:23:37.292] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:37.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:85:0) after 1m0s
[12:24:37.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:85:0)
[12:24:37.311] Timer tick, asking Buildbucket for the build status
[12:24:37.599] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:37.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:86:0) after 1m0s
[12:25:37.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:86:0)
[12:25:37.652] Timer tick, asking Buildbucket for the build status
[12:25:37.923] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:37.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:87:0) after 1m0s
[12:26:37.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:87:0)
[12:26:37.908] Timer tick, asking Buildbucket for the build status
[12:26:38.358] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:38.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:88:0) after 1m0s
[12:27:38.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:88:0)
[12:27:38.375] Timer tick, asking Buildbucket for the build status
[12:27:38.855] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:38.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:89:0) after 1m0s
[12:28:38.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:89:0)
[12:28:38.899] Timer tick, asking Buildbucket for the build status
[12:28:39.041] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:39.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:90:0) after 1m0s
[12:29:39.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:90:0)
[12:29:39.084] Timer tick, asking Buildbucket for the build status
[12:29:39.247] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:39.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:91:0) after 1m0s
[12:30:39.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:91:0)
[12:30:39.277] Timer tick, asking Buildbucket for the build status
[12:30:39.469] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:39.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:92:0) after 1m0s
[12:31:39.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:92:0)
[12:31:39.535] Timer tick, asking Buildbucket for the build status
[12:31:39.905] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:39.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:93:0) after 1m0s
[12:32:39.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:93:0)
[12:32:39.943] Timer tick, asking Buildbucket for the build status
[12:32:40.498] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:40.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:94:0) after 1m0s
[12:33:40.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:94:0)
[12:33:40.535] Timer tick, asking Buildbucket for the build status
[12:33:40.673] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:40.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:95:0) after 1m0s
[12:34:40.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:95:0)
[12:34:40.705] Timer tick, asking Buildbucket for the build status
[12:34:40.952] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:40.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:96:0) after 1m0s
[12:35:40.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:96:0)
[12:35:40.991] Timer tick, asking Buildbucket for the build status
[12:35:41.348] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:41.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:97:0) after 1m0s
[12:36:41.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:97:0)
[12:36:41.402] Timer tick, asking Buildbucket for the build status
[12:36:41.683] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:41.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:98:0) after 1m0s
[12:37:41.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:98:0)
[12:37:41.714] Timer tick, asking Buildbucket for the build status
[12:37:43.306] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:43.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:99:0) after 1m0s
[12:38:43.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:99:0)
[12:38:43.410] Timer tick, asking Buildbucket for the build status
[12:38:43.582] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:43.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:100:0) after 1m0s
[12:39:43.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:100:0)
[12:39:43.636] Timer tick, asking Buildbucket for the build status
[12:39:43.825] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:43.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:101:0) after 1m0s
[12:40:43.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:101:0)
[12:40:43.832] Timer tick, asking Buildbucket for the build status
[12:40:44.115] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:44.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:102:0) after 1m0s
[12:41:44.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:102:0)
[12:41:44.213] Timer tick, asking Buildbucket for the build status
[12:41:44.419] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:44.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:103:0) after 1m0s
[12:42:44.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:103:0)
[12:42:44.479] Timer tick, asking Buildbucket for the build status
[12:42:45.017] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:45.017] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:104:0) after 1m0s
[12:43:45.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:104:0)
[12:43:45.045] Timer tick, asking Buildbucket for the build status
[12:43:45.214] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:45.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:105:0) after 1m0s
[12:44:45.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:105:0)
[12:44:45.283] Timer tick, asking Buildbucket for the build status
[12:44:45.659] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:45.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:106:0) after 1m0s
[12:45:45.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:106:0)
[12:45:45.697] Timer tick, asking Buildbucket for the build status
[12:45:45.946] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:45.946] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:107:0) after 1m0s
[12:46:45.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:107:0)
[12:46:45.957] Timer tick, asking Buildbucket for the build status
[12:46:46.091] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:46.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:108:0) after 1m0s
[12:47:46.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:108:0)
[12:47:46.147] Timer tick, asking Buildbucket for the build status
[12:47:46.400] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:46.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:109:0) after 1m0s
[12:48:46.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:109:0)
[12:48:46.460] Timer tick, asking Buildbucket for the build status
[12:48:46.623] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:46.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:110:0) after 1m0s
[12:49:46.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:110:0)
[12:49:46.765] Timer tick, asking Buildbucket for the build status
[12:49:47.431] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:47.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:111:0) after 1m0s
[12:50:47.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:111:0)
[12:50:47.522] Timer tick, asking Buildbucket for the build status
[12:50:47.770] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:47.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:112:0) after 1m0s
[12:51:47.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:112:0)
[12:51:47.907] Timer tick, asking Buildbucket for the build status
[12:51:48.106] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:48.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:113:0) after 1m0s
[12:52:48.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:113:0)
[12:52:48.341] Timer tick, asking Buildbucket for the build status
[12:52:50.886] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:50.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:114:0) after 1m0s
[12:53:51.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:114:0)
[12:53:51.102] Timer tick, asking Buildbucket for the build status
[12:53:51.293] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:51.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:115:0) after 1m0s
[12:54:51.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:115:0)
[12:54:51.368] Timer tick, asking Buildbucket for the build status
[12:54:52.078] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:52.078] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:116:0) after 1m0s
[12:55:52.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:116:0)
[12:55:52.205] Timer tick, asking Buildbucket for the build status
[12:55:52.349] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:52.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:117:0) after 1m0s
[12:56:52.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:117:0)
[12:56:52.514] Timer tick, asking Buildbucket for the build status
[12:56:52.849] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:52.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:118:0) after 1m0s
[12:57:52.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:118:0)
[12:57:52.886] Timer tick, asking Buildbucket for the build status
[12:57:53.096] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:53.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:119:0) after 1m0s
[12:58:53.180] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:119:0)
[12:58:53.180] Timer tick, asking Buildbucket for the build status
[12:58:53.327] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:53.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:120:0) after 1m0s
[12:59:53.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:120:0)
[12:59:53.368] Timer tick, asking Buildbucket for the build status
[12:59:53.478] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:53.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:121:0) after 1m0s
[13:00:53.509] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:121:0)
[13:00:53.509] Timer tick, asking Buildbucket for the build status
[13:00:53.635] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:53.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:122:0) after 1m0s
[13:01:53.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:122:0)
[13:01:53.702] Timer tick, asking Buildbucket for the build status
[13:01:54.155] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:54.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:123:0) after 1m0s
[13:02:54.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:123:0)
[13:02:54.199] Timer tick, asking Buildbucket for the build status
[13:02:54.461] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:54.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:124:0) after 1m0s
[13:03:54.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:124:0)
[13:03:54.587] Timer tick, asking Buildbucket for the build status
[13:03:54.724] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:54.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:125:0) after 1m0s
[13:04:54.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:125:0)
[13:04:54.724] Timer tick, asking Buildbucket for the build status
[13:04:54.925] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:54.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:126:0) after 1m0s
[13:05:54.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:126:0)
[13:05:54.969] Timer tick, asking Buildbucket for the build status
[13:05:55.316] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:55.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:127:0) after 1m0s
[13:06:55.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:127:0)
[13:06:55.423] Timer tick, asking Buildbucket for the build status
[13:06:55.657] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:55.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:128:0) after 1m0s
[13:07:55.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:128:0)
[13:07:55.700] Timer tick, asking Buildbucket for the build status
[13:07:55.844] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:55.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:129:0) after 1m0s
[13:08:55.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:129:0)
[13:08:55.880] Timer tick, asking Buildbucket for the build status
[13:08:56.029] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:56.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:130:0) after 1m0s
[13:09:56.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:130:0)
[13:09:56.115] Timer tick, asking Buildbucket for the build status
[13:09:56.285] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:56.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:131:0) after 1m0s
[13:10:56.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:131:0)
[13:10:56.323] Timer tick, asking Buildbucket for the build status
[13:10:56.479] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:56.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:132:0) after 1m0s
[13:11:56.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:132:0)
[13:11:56.489] Timer tick, asking Buildbucket for the build status
[13:11:56.835] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:56.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:133:0) after 1m0s
[13:12:56.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:133:0)
[13:12:56.893] Timer tick, asking Buildbucket for the build status
[13:13:01.017] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:01.017] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:134:0) after 1m0s
[13:14:02.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:134:0)
[13:14:02.627] Timer tick, asking Buildbucket for the build status
[13:14:02.931] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:02.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:135:0) after 1m0s
[13:15:03.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:135:0)
[13:15:03.028] Timer tick, asking Buildbucket for the build status
[13:15:03.197] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:03.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:136:0) after 1m0s
[13:16:03.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:136:0)
[13:16:03.268] Timer tick, asking Buildbucket for the build status
[13:16:03.524] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:03.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:137:0) after 1m0s
[13:17:03.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:137:0)
[13:17:03.640] Timer tick, asking Buildbucket for the build status
[13:17:04.103] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:04.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:138:0) after 1m0s
[13:18:04.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:138:0)
[13:18:04.239] Timer tick, asking Buildbucket for the build status
[13:18:04.406] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:04.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:139:0) after 1m0s
[13:19:04.501] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:139:0)
[13:19:04.501] Timer tick, asking Buildbucket for the build status
[13:19:04.654] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:04.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:140:0) after 1m0s
[13:20:04.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:140:0)
[13:20:04.739] Timer tick, asking Buildbucket for the build status
[13:20:04.925] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:04.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:141:0) after 1m0s
[13:21:04.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:141:0)
[13:21:04.992] Timer tick, asking Buildbucket for the build status
[13:21:05.324] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:05.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:142:0) after 1m0s
[13:22:05.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:142:0)
[13:22:05.564] Timer tick, asking Buildbucket for the build status
[13:22:05.773] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:05.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:143:0) after 1m0s
[13:23:05.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:143:0)
[13:23:05.828] Timer tick, asking Buildbucket for the build status
[13:23:06.019] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:06.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:144:0) after 1m0s
[13:24:06.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:144:0)
[13:24:06.268] Timer tick, asking Buildbucket for the build status
[13:24:06.659] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:06.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:145:0) after 1m0s
[13:25:06.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:145:0)
[13:25:06.866] Timer tick, asking Buildbucket for the build status
[13:25:07.042] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:07.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:146:0) after 1m0s
[13:26:07.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:146:0)
[13:26:07.108] Timer tick, asking Buildbucket for the build status
[13:26:07.251] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:07.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:147:0) after 1m0s
[13:27:07.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:147:0)
[13:27:07.274] Timer tick, asking Buildbucket for the build status
[13:27:07.424] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:07.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:148:0) after 1m0s
[13:28:07.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:148:0)
[13:28:07.534] Timer tick, asking Buildbucket for the build status
[13:28:07.661] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:07.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:149:0) after 1m0s
[13:29:07.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:149:0)
[13:29:07.702] Timer tick, asking Buildbucket for the build status
[13:29:07.849] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:07.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:150:0) after 1m0s
[13:30:07.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:150:0)
[13:30:07.938] Timer tick, asking Buildbucket for the build status
[13:30:08.289] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:08.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:151:0) after 1m0s
[13:31:08.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:151:0)
[13:31:08.424] Timer tick, asking Buildbucket for the build status
[13:31:08.794] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:08.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:152:0) after 1m0s
[13:32:08.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:152:0)
[13:32:08.880] Timer tick, asking Buildbucket for the build status
[13:32:09.088] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:09.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:153:0) after 1m0s
[13:33:09.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:153:0)
[13:33:09.123] Timer tick, asking Buildbucket for the build status
[13:33:09.496] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:09.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:154:0) after 1m0s
[13:34:09.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:154:0)
[13:34:09.581] Timer tick, asking Buildbucket for the build status
[13:34:09.806] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:09.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:155:0) after 1m0s
[13:35:09.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:155:0)
[13:35:09.864] Timer tick, asking Buildbucket for the build status
[13:35:10.082] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:10.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:156:0) after 1m0s
[13:36:10.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:156:0)
[13:36:10.106] Timer tick, asking Buildbucket for the build status
[13:36:11.206] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:11.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:157:0) after 1m0s
[13:37:11.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:157:0)
[13:37:11.244] Timer tick, asking Buildbucket for the build status
[13:37:11.420] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:11.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:158:0) after 1m0s
[13:38:11.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:158:0)
[13:38:11.495] Timer tick, asking Buildbucket for the build status
[13:38:11.640] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:11.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:159:0) after 1m0s
[13:39:11.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:159:0)
[13:39:11.774] Timer tick, asking Buildbucket for the build status
[13:39:11.997] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:11.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:160:0) after 1m0s
[13:40:12.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:160:0)
[13:40:12.095] Timer tick, asking Buildbucket for the build status
[13:40:12.230] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:12.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:161:0) after 1m0s
[13:41:12.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:161:0)
[13:41:12.268] Timer tick, asking Buildbucket for the build status
[13:41:12.415] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:12.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:162:0) after 1m0s
[13:42:12.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:162:0)
[13:42:12.421] Timer tick, asking Buildbucket for the build status
[13:42:12.654] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:12.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:163:0) after 1m0s
[13:43:12.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:163:0)
[13:43:12.756] Timer tick, asking Buildbucket for the build status
[13:43:13.011] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:13.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:164:0) after 1m0s
[13:44:13.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:164:0)
[13:44:13.078] Timer tick, asking Buildbucket for the build status
[13:44:13.274] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:13.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:165:0) after 1m0s
[13:45:13.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:165:0)
[13:45:13.354] Timer tick, asking Buildbucket for the build status
[13:45:13.545] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:13.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:166:0) after 1m0s
[13:46:13.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:166:0)
[13:46:13.620] Timer tick, asking Buildbucket for the build status
[13:46:13.799] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:13.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:167:0) after 1m0s
[13:47:14.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:167:0)
[13:47:14.242] Timer tick, asking Buildbucket for the build status
[13:47:14.552] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:14.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:168:0) after 1m0s
[13:48:14.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:168:0)
[13:48:14.668] Timer tick, asking Buildbucket for the build status
[13:48:14.848] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:14.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:169:0) after 1m0s
[13:49:14.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:169:0)
[13:49:14.991] Timer tick, asking Buildbucket for the build status
[13:49:15.122] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:15.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:170:0) after 1m0s
[13:50:15.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:170:0)
[13:50:15.967] Timer tick, asking Buildbucket for the build status
[13:50:16.287] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:16.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:171:0) after 1m0s
[13:51:16.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:171:0)
[13:51:16.659] Timer tick, asking Buildbucket for the build status
[13:51:16.852] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:16.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:172:0) after 1m0s
[13:52:17.072] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:172:0)
[13:52:17.072] Timer tick, asking Buildbucket for the build status
[13:52:17.332] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:17.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:173:0) after 1m0s
[13:53:17.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:173:0)
[13:53:17.385] Timer tick, asking Buildbucket for the build status
[13:53:17.548] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:17.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:174:0) after 1m0s
[13:54:17.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:174:0)
[13:54:17.664] Timer tick, asking Buildbucket for the build status
[13:54:17.902] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:17.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:175:0) after 1m0s
[13:55:17.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:175:0)
[13:55:17.913] Timer tick, asking Buildbucket for the build status
[13:55:18.095] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:18.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:176:0) after 1m0s
[13:56:18.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:176:0)
[13:56:18.094] Timer tick, asking Buildbucket for the build status
[13:56:18.213] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:18.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:177:0) after 1m0s
[13:57:18.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:177:0)
[13:57:18.274] Timer tick, asking Buildbucket for the build status
[13:57:18.447] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:18.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:178:0) after 1m0s
[13:58:18.504] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:178:0)
[13:58:18.504] Timer tick, asking Buildbucket for the build status
[13:58:18.638] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:18.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:179:0) after 1m0s
[13:59:18.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:179:0)
[13:59:18.684] Timer tick, asking Buildbucket for the build status
[13:59:18.970] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:18.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:180:0) after 1m0s
[14:00:19.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:180:0)
[14:00:19.052] Timer tick, asking Buildbucket for the build status
[14:00:20.056] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:20.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:181:0) after 1m0s
[14:01:20.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:181:0)
[14:01:20.172] Timer tick, asking Buildbucket for the build status
[14:01:20.841] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:20.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:182:0) after 1m0s
[14:02:20.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:182:0)
[14:02:20.891] Timer tick, asking Buildbucket for the build status
[14:02:21.175] Build 8879061975851442864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:21.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044492038483014224:183:0) after 1m0s
[14:03:16.008] Received PubSub notification, asking Buildbucket for the build status
[14:03:16.194] Build 8879061975851442864: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:03:16.194] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1590674594871826",
    "created_by": "project:infra",
    "created_ts": "1590663662059574",
    "id": "8879061975851442864",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4158.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ef2033f7-87db-46bb-a954-1ce8f88aa011\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4158.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"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-3h44\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"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\": [\"5142-e16b32c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1590663721171450",
    "status": "COMPLETED",
    "status_changed_ts": "1590674595304543",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9044492038483014224",
      "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/8879061975851442864/+/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:4c73c2d521d75110",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1590674595363946",
    "url": "https://ci.chromium.org/b/8879061975851442864",
    "utcnow_ts": "1590674596181144"
  }
}
[14:03:16.195] Invocation finished in 3h2m16.030064628s with status SUCCEEDED