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

• parent_buildername:publish_tarball
• user_agent:recipe

[09:13:04.278] New invocation is queued and will start shortly
[09:13:04.278] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[09:13:05.461] Starting the invocation (attempt 1)
[09:13:05.536] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:13:05.537] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:13:05.537] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9048303901548961792",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"84.0.4115.4\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"c5147217-b870-40a6-a333-42b4b934754e\",\"title\":\"publish_tarball/0\"}]},\"version\":\"84.0.4115.4\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9048303901548961792",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[09:13:06.002] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1587028385632139",
    "id": "8882873839465308688",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4115.4\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"c5147217-b870-40a6-a333-42b4b934754e\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4115.4\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1587028385814195",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9048303901548961792",
      "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/8882873839465308688/+/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": "1587028385815551",
    "url": "https://ci.chromium.org/b/8882873839465308688",
    "utcnow_ts": "1587028385995321"
  }
}
[09:13:06.002] Task URL: https://ci.chromium.org/b/8882873839465308688
[09:13:06.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:2:0) after 1m0s
[09:14:06.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:2:0)
[09:14:06.029] Timer tick, asking Buildbucket for the build status
[09:14:06.378] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:14:06.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:3:0) after 1m0s
[09:15:06.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:3:0)
[09:15:06.421] Timer tick, asking Buildbucket for the build status
[09:15:08.456] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:15:08.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:4:0) after 1m0s
[09:16:08.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:4:0)
[09:16:08.678] Timer tick, asking Buildbucket for the build status
[09:16:08.979] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:16:08.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:5:0) after 1m0s
[09:17:08.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:5:0)
[09:17:08.971] Timer tick, asking Buildbucket for the build status
[09:17:09.187] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:17:09.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:6:0) after 1m0s
[09:18:09.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:6:0)
[09:18:09.206] Timer tick, asking Buildbucket for the build status
[09:18:09.490] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:18:09.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:7:0) after 1m0s
[09:19:11.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:7:0)
[09:19:11.766] Timer tick, asking Buildbucket for the build status
[09:19:12.179] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:19:12.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:8:0) after 1m0s
[09:20:12.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:8:0)
[09:20:12.316] Timer tick, asking Buildbucket for the build status
[09:20:12.661] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:20:12.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:9:0) after 1m0s
[09:21:12.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:9:0)
[09:21:12.838] Timer tick, asking Buildbucket for the build status
[09:21:13.058] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:21:13.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:10:0) after 1m0s
[09:22:13.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:10:0)
[09:22:13.166] Timer tick, asking Buildbucket for the build status
[09:22:13.343] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:22:13.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:11:0) after 1m0s
[09:23:13.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:11:0)
[09:23:13.467] Timer tick, asking Buildbucket for the build status
[09:23:13.634] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:23:13.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:12:0) after 1m0s
[09:24:13.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:12:0)
[09:24:13.608] Timer tick, asking Buildbucket for the build status
[09:24:13.812] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:24:13.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:13:0) after 1m0s
[09:25:13.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:13:0)
[09:25:13.864] Timer tick, asking Buildbucket for the build status
[09:25:14.029] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:25:14.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:14:0) after 1m0s
[09:26:14.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:14:0)
[09:26:14.103] Timer tick, asking Buildbucket for the build status
[09:26:14.281] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:26:14.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:15:0) after 1m0s
[09:27:14.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:15:0)
[09:27:14.372] Timer tick, asking Buildbucket for the build status
[09:27:14.870] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:27:14.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:16:0) after 1m0s
[09:28:15.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:16:0)
[09:28:15.075] Timer tick, asking Buildbucket for the build status
[09:28:15.384] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:28:15.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:17:0) after 1m0s
[09:29:15.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:17:0)
[09:29:15.592] Timer tick, asking Buildbucket for the build status
[09:29:15.824] Build 8882873839465308688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:29:15.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:18:0) after 1m0s
[09:30:03.996] Received PubSub notification, asking Buildbucket for the build status
[09:30:04.707] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:15.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:18:0)
[09:30:15.928] Timer tick, asking Buildbucket for the build status
[09:30:16.547] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:16.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:20:0) after 1m0s
[09:31:16.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:20:0)
[09:31:16.693] Timer tick, asking Buildbucket for the build status
[09:31:17.245] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:17.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:21:0) after 1m0s
[09:32:17.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:21:0)
[09:32:17.286] Timer tick, asking Buildbucket for the build status
[09:32:17.670] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:17.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:22:0) after 1m0s
[09:33:17.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:22:0)
[09:33:17.850] Timer tick, asking Buildbucket for the build status
[09:33:18.043] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:18.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:23:0) after 1m0s
[09:34:18.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:23:0)
[09:34:18.132] Timer tick, asking Buildbucket for the build status
[09:34:18.301] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:18.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:24:0) after 1m0s
[09:35:18.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:24:0)
[09:35:18.362] Timer tick, asking Buildbucket for the build status
[09:35:19.006] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:19.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:25:0) after 1m0s
[09:36:19.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:25:0)
[09:36:19.075] Timer tick, asking Buildbucket for the build status
[09:36:19.315] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:19.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:26:0) after 1m0s
[09:37:19.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:26:0)
[09:37:19.318] Timer tick, asking Buildbucket for the build status
[09:37:19.455] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:19.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:27:0) after 1m0s
[09:38:19.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:27:0)
[09:38:19.487] Timer tick, asking Buildbucket for the build status
[09:38:20.221] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:20.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:28:0) after 1m0s
[09:39:20.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:28:0)
[09:39:20.291] Timer tick, asking Buildbucket for the build status
[09:39:20.490] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:20.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:29:0) after 1m0s
[09:40:20.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:29:0)
[09:40:20.494] Timer tick, asking Buildbucket for the build status
[09:40:20.655] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:20.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:30:0) after 1m0s
[09:41:20.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:30:0)
[09:41:20.642] Timer tick, asking Buildbucket for the build status
[09:41:20.782] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:20.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:31:0) after 1m0s
[09:42:20.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:31:0)
[09:42:20.816] Timer tick, asking Buildbucket for the build status
[09:42:23.491] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:23.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:32:0) after 1m0s
[09:43:23.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:32:0)
[09:43:23.634] Timer tick, asking Buildbucket for the build status
[09:43:24.004] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:24.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:33:0) after 1m0s
[09:44:24.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:33:0)
[09:44:24.174] Timer tick, asking Buildbucket for the build status
[09:44:25.413] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:25.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:34:0) after 1m0s
[09:45:25.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:34:0)
[09:45:25.478] Timer tick, asking Buildbucket for the build status
[09:45:25.712] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:25.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:35:0) after 1m0s
[09:46:25.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:35:0)
[09:46:25.892] Timer tick, asking Buildbucket for the build status
[09:46:26.251] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:26.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:36:0) after 1m0s
[09:47:26.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:36:0)
[09:47:26.351] Timer tick, asking Buildbucket for the build status
[09:47:26.779] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:26.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:37:0) after 1m0s
[09:48:26.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:37:0)
[09:48:26.885] Timer tick, asking Buildbucket for the build status
[09:48:27.155] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:27.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:38:0) after 1m0s
[09:49:27.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:38:0)
[09:49:27.362] Timer tick, asking Buildbucket for the build status
[09:49:27.553] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:27.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:39:0) after 1m0s
[09:50:27.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:39:0)
[09:50:27.711] Timer tick, asking Buildbucket for the build status
[09:50:27.953] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:27.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:40:0) after 1m0s
[09:51:28.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:40:0)
[09:51:28.123] Timer tick, asking Buildbucket for the build status
[09:51:28.405] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:28.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:41:0) after 1m0s
[09:52:28.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:41:0)
[09:52:28.542] Timer tick, asking Buildbucket for the build status
[09:52:29.346] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:29.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:42:0) after 1m0s
[09:53:29.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:42:0)
[09:53:29.406] Timer tick, asking Buildbucket for the build status
[09:53:29.686] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:29.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:43:0) after 1m0s
[09:54:29.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:43:0)
[09:54:29.739] Timer tick, asking Buildbucket for the build status
[09:54:30.067] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:30.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:44:0) after 1m0s
[09:55:30.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:44:0)
[09:55:30.177] Timer tick, asking Buildbucket for the build status
[09:55:30.685] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:30.685] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:45:0) after 1m0s
[09:56:30.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:45:0)
[09:56:30.730] Timer tick, asking Buildbucket for the build status
[09:56:31.000] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:31.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:46:0) after 1m0s
[09:57:31.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:46:0)
[09:57:31.049] Timer tick, asking Buildbucket for the build status
[09:57:31.851] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:31.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:47:0) after 1m0s
[09:58:31.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:47:0)
[09:58:31.912] Timer tick, asking Buildbucket for the build status
[09:58:32.172] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:32.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:48:0) after 1m0s
[09:59:32.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:48:0)
[09:59:32.159] Timer tick, asking Buildbucket for the build status
[09:59:32.306] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:32.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:49:0) after 1m0s
[10:00:32.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:49:0)
[10:00:32.307] Timer tick, asking Buildbucket for the build status
[10:00:32.743] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:32.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:50:0) after 1m0s
[10:01:32.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:50:0)
[10:01:32.806] Timer tick, asking Buildbucket for the build status
[10:01:32.965] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:32.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:51:0) after 1m0s
[10:02:32.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:51:0)
[10:02:32.992] Timer tick, asking Buildbucket for the build status
[10:02:33.358] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:33.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:52:0) after 1m0s
[10:03:33.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:52:0)
[10:03:33.471] Timer tick, asking Buildbucket for the build status
[10:03:34.216] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:34.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:53:0) after 1m0s
[10:04:34.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:53:0)
[10:04:34.307] Timer tick, asking Buildbucket for the build status
[10:04:34.494] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:34.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:54:0) after 1m0s
[10:05:34.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:54:0)
[10:05:34.606] Timer tick, asking Buildbucket for the build status
[10:05:35.554] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:35.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:55:0) after 1m0s
[10:06:35.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:55:0)
[10:06:35.605] Timer tick, asking Buildbucket for the build status
[10:06:35.814] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:35.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:56:0) after 1m0s
[10:07:35.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:56:0)
[10:07:35.884] Timer tick, asking Buildbucket for the build status
[10:07:40.587] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:40.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:57:0) after 1m0s
[10:08:40.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:57:0)
[10:08:40.699] Timer tick, asking Buildbucket for the build status
[10:08:40.965] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:40.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:58:0) after 1m0s
[10:09:41.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:58:0)
[10:09:41.112] Timer tick, asking Buildbucket for the build status
[10:09:41.659] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:41.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:59:0) after 1m0s
[10:10:41.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:59:0)
[10:10:41.827] Timer tick, asking Buildbucket for the build status
[10:10:41.969] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:41.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:60:0) after 1m0s
[10:11:41.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:60:0)
[10:11:41.995] Timer tick, asking Buildbucket for the build status
[10:11:42.154] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:42.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:61:0) after 1m0s
[10:12:42.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:61:0)
[10:12:42.188] Timer tick, asking Buildbucket for the build status
[10:12:42.638] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:42.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:62:0) after 1m0s
[10:13:42.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:62:0)
[10:13:42.667] Timer tick, asking Buildbucket for the build status
[10:13:42.785] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:42.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:63:0) after 1m0s
[10:14:42.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:63:0)
[10:14:42.843] Timer tick, asking Buildbucket for the build status
[10:14:43.005] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:43.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:64:0) after 1m0s
[10:15:43.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:64:0)
[10:15:43.073] Timer tick, asking Buildbucket for the build status
[10:15:43.336] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:43.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:65:0) after 1m0s
[10:16:43.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:65:0)
[10:16:43.461] Timer tick, asking Buildbucket for the build status
[10:16:43.983] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:43.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:66:0) after 1m0s
[10:17:44.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:66:0)
[10:17:44.023] Timer tick, asking Buildbucket for the build status
[10:17:44.465] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:44.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:67:0) after 1m0s
[10:18:44.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:67:0)
[10:18:44.565] Timer tick, asking Buildbucket for the build status
[10:18:44.766] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:44.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:68:0) after 1m0s
[10:19:44.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:68:0)
[10:19:44.822] Timer tick, asking Buildbucket for the build status
[10:19:44.934] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:44.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:69:0) after 1m0s
[10:20:44.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:69:0)
[10:20:44.995] Timer tick, asking Buildbucket for the build status
[10:20:45.102] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:45.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:70:0) after 1m0s
[10:21:45.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:70:0)
[10:21:45.127] Timer tick, asking Buildbucket for the build status
[10:21:45.431] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:45.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:71:0) after 1m0s
[10:22:45.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:71:0)
[10:22:45.459] Timer tick, asking Buildbucket for the build status
[10:22:45.854] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:45.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:72:0) after 1m0s
[10:23:45.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:72:0)
[10:23:45.882] Timer tick, asking Buildbucket for the build status
[10:23:46.177] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:46.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:73:0) after 1m0s
[10:24:46.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:73:0)
[10:24:46.231] Timer tick, asking Buildbucket for the build status
[10:24:46.412] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:46.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:74:0) after 1m0s
[10:25:46.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:74:0)
[10:25:46.466] Timer tick, asking Buildbucket for the build status
[10:25:46.932] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:46.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:75:0) after 1m0s
[10:26:46.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:75:0)
[10:26:46.977] Timer tick, asking Buildbucket for the build status
[10:26:47.205] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:47.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:76:0) after 1m0s
[10:27:47.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:76:0)
[10:27:47.237] Timer tick, asking Buildbucket for the build status
[10:27:52.617] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:52.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:77:0) after 1m0s
[10:28:52.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:77:0)
[10:28:52.662] Timer tick, asking Buildbucket for the build status
[10:28:53.045] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:53.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:78:0) after 1m0s
[10:29:53.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:78:0)
[10:29:53.084] Timer tick, asking Buildbucket for the build status
[10:29:53.285] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:53.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:79:0) after 1m0s
[10:30:53.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:79:0)
[10:30:53.359] Timer tick, asking Buildbucket for the build status
[10:30:53.497] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:53.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:80:0) after 1m0s
[10:31:53.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:80:0)
[10:31:53.553] Timer tick, asking Buildbucket for the build status
[10:31:53.763] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:53.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:81:0) after 1m0s
[10:32:53.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:81:0)
[10:32:53.825] Timer tick, asking Buildbucket for the build status
[10:32:54.228] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:54.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:82:0) after 1m0s
[10:33:54.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:82:0)
[10:33:54.731] Timer tick, asking Buildbucket for the build status
[10:33:55.035] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:55.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:83:0) after 1m0s
[10:34:55.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:83:0)
[10:34:55.087] Timer tick, asking Buildbucket for the build status
[10:34:55.292] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:55.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:84:0) after 1m0s
[10:35:55.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:84:0)
[10:35:55.327] Timer tick, asking Buildbucket for the build status
[10:35:55.508] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:55.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:85:0) after 1m0s
[10:36:55.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:85:0)
[10:36:55.588] Timer tick, asking Buildbucket for the build status
[10:36:55.765] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:55.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:86:0) after 1m0s
[10:37:55.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:86:0)
[10:37:55.830] Timer tick, asking Buildbucket for the build status
[10:37:57.625] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:57.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:87:0) after 1m0s
[10:38:57.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:87:0)
[10:38:57.646] Timer tick, asking Buildbucket for the build status
[10:38:57.900] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:57.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:88:0) after 1m0s
[10:39:57.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:88:0)
[10:39:57.893] Timer tick, asking Buildbucket for the build status
[10:39:58.551] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:58.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:89:0) after 1m0s
[10:40:58.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:89:0)
[10:40:58.581] Timer tick, asking Buildbucket for the build status
[10:40:59.571] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:59.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:90:0) after 1m0s
[10:41:59.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:90:0)
[10:41:59.653] Timer tick, asking Buildbucket for the build status
[10:42:00.116] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:00.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:91:0) after 1m0s
[10:43:00.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:91:0)
[10:43:00.138] Timer tick, asking Buildbucket for the build status
[10:43:00.276] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:00.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:92:0) after 1m0s
[10:44:00.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:92:0)
[10:44:00.372] Timer tick, asking Buildbucket for the build status
[10:44:00.507] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:00.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:93:0) after 1m0s
[10:45:00.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:93:0)
[10:45:00.717] Timer tick, asking Buildbucket for the build status
[10:45:00.851] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:00.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:94:0) after 1m0s
[10:46:01.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:94:0)
[10:46:01.041] Timer tick, asking Buildbucket for the build status
[10:46:01.156] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:01.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:95:0) after 1m0s
[10:47:01.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:95:0)
[10:47:01.320] Timer tick, asking Buildbucket for the build status
[10:47:01.466] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:01.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:96:0) after 1m0s
[10:48:01.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:96:0)
[10:48:01.634] Timer tick, asking Buildbucket for the build status
[10:48:01.799] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:01.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:97:0) after 1m0s
[10:49:01.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:97:0)
[10:49:01.837] Timer tick, asking Buildbucket for the build status
[10:49:01.963] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:01.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:98:0) after 1m0s
[10:50:02.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:98:0)
[10:50:02.003] Timer tick, asking Buildbucket for the build status
[10:50:02.197] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:02.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:99:0) after 1m0s
[10:51:02.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:99:0)
[10:51:02.235] Timer tick, asking Buildbucket for the build status
[10:51:02.441] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:02.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:100:0) after 1m0s
[10:52:02.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:100:0)
[10:52:02.567] Timer tick, asking Buildbucket for the build status
[10:52:02.865] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:02.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:101:0) after 1m0s
[10:53:02.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:101:0)
[10:53:02.930] Timer tick, asking Buildbucket for the build status
[10:53:04.400] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:04.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:102:0) after 1m0s
[10:54:04.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:102:0)
[10:54:04.533] Timer tick, asking Buildbucket for the build status
[10:54:04.884] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:04.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:103:0) after 1m0s
[10:55:04.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:103:0)
[10:55:04.986] Timer tick, asking Buildbucket for the build status
[10:55:05.375] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:05.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:104:0) after 1m0s
[10:56:05.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:104:0)
[10:56:05.425] Timer tick, asking Buildbucket for the build status
[10:56:06.013] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:06.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:105:0) after 1m0s
[10:57:06.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:105:0)
[10:57:06.178] Timer tick, asking Buildbucket for the build status
[10:57:06.451] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:06.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:106:0) after 1m0s
[10:58:06.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:106:0)
[10:58:06.611] Timer tick, asking Buildbucket for the build status
[10:58:08.983] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:08.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:107:0) after 1m0s
[10:59:09.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:107:0)
[10:59:09.156] Timer tick, asking Buildbucket for the build status
[10:59:09.558] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:09.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:108:0) after 1m0s
[11:00:09.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:108:0)
[11:00:09.657] Timer tick, asking Buildbucket for the build status
[11:00:09.791] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:09.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:109:0) after 1m0s
[11:01:09.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:109:0)
[11:01:09.870] Timer tick, asking Buildbucket for the build status
[11:01:10.016] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:10.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:110:0) after 1m0s
[11:02:10.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:110:0)
[11:02:10.147] Timer tick, asking Buildbucket for the build status
[11:02:10.298] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:10.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:111:0) after 1m0s
[11:03:10.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:111:0)
[11:03:10.574] Timer tick, asking Buildbucket for the build status
[11:03:10.736] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:10.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:112:0) after 1m0s
[11:04:10.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:112:0)
[11:04:10.802] Timer tick, asking Buildbucket for the build status
[11:04:11.034] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:11.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:113:0) after 1m0s
[11:05:11.136] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:113:0)
[11:05:11.136] Timer tick, asking Buildbucket for the build status
[11:05:11.306] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:11.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:114:0) after 1m0s
[11:06:11.305] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:114:0)
[11:06:11.305] Timer tick, asking Buildbucket for the build status
[11:06:13.726] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:13.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:115:0) after 1m0s
[11:07:13.781] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:115:0)
[11:07:13.781] Timer tick, asking Buildbucket for the build status
[11:07:14.115] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:14.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:116:0) after 1m0s
[11:08:14.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:116:0)
[11:08:14.195] Timer tick, asking Buildbucket for the build status
[11:08:14.394] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:14.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:117:0) after 1m0s
[11:09:14.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:117:0)
[11:09:14.503] Timer tick, asking Buildbucket for the build status
[11:09:15.302] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:15.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:118:0) after 1m0s
[11:10:15.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:118:0)
[11:10:15.515] Timer tick, asking Buildbucket for the build status
[11:10:15.733] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:15.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:119:0) after 1m0s
[11:11:15.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:119:0)
[11:11:15.877] Timer tick, asking Buildbucket for the build status
[11:11:16.007] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:16.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:120:0) after 1m0s
[11:12:16.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:120:0)
[11:12:16.109] Timer tick, asking Buildbucket for the build status
[11:12:16.267] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:16.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:121:0) after 1m0s
[11:13:16.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:121:0)
[11:13:16.344] Timer tick, asking Buildbucket for the build status
[11:13:16.782] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:16.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:122:0) after 1m0s
[11:14:16.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:122:0)
[11:14:16.846] Timer tick, asking Buildbucket for the build status
[11:14:16.978] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:16.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:123:0) after 1m0s
[11:15:17.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:123:0)
[11:15:17.095] Timer tick, asking Buildbucket for the build status
[11:15:17.284] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:17.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:124:0) after 1m0s
[11:16:17.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:124:0)
[11:16:17.302] Timer tick, asking Buildbucket for the build status
[11:16:17.500] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:17.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:125:0) after 1m0s
[11:17:17.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:125:0)
[11:17:17.602] Timer tick, asking Buildbucket for the build status
[11:17:17.796] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:17.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:126:0) after 1m0s
[11:18:17.855] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:126:0)
[11:18:17.855] Timer tick, asking Buildbucket for the build status
[11:18:18.066] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:18.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:127:0) after 1m0s
[11:19:18.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:127:0)
[11:19:18.205] Timer tick, asking Buildbucket for the build status
[11:19:18.338] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:18.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:128:0) after 1m0s
[11:20:18.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:128:0)
[11:20:18.406] Timer tick, asking Buildbucket for the build status
[11:20:18.562] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:18.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:129:0) after 1m0s
[11:21:18.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:129:0)
[11:21:18.588] Timer tick, asking Buildbucket for the build status
[11:21:18.904] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:18.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:130:0) after 1m0s
[11:22:18.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:130:0)
[11:22:18.967] Timer tick, asking Buildbucket for the build status
[11:22:19.638] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:19.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:131:0) after 1m0s
[11:23:19.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:131:0)
[11:23:19.693] Timer tick, asking Buildbucket for the build status
[11:23:19.869] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:19.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:132:0) after 1m0s
[11:24:19.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:132:0)
[11:24:19.973] Timer tick, asking Buildbucket for the build status
[11:24:20.152] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:20.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:133:0) after 1m0s
[11:25:20.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:133:0)
[11:25:20.205] Timer tick, asking Buildbucket for the build status
[11:25:20.534] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:20.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:134:0) after 1m0s
[11:26:20.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:134:0)
[11:26:20.642] Timer tick, asking Buildbucket for the build status
[11:26:20.749] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:20.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:135:0) after 1m0s
[11:27:20.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:135:0)
[11:27:20.983] Timer tick, asking Buildbucket for the build status
[11:27:21.702] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:21.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:136:0) after 1m0s
[11:28:21.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:136:0)
[11:28:21.893] Timer tick, asking Buildbucket for the build status
[11:28:22.039] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:22.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:137:0) after 1m0s
[11:29:22.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:137:0)
[11:29:22.200] Timer tick, asking Buildbucket for the build status
[11:29:22.374] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:22.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:138:0) after 1m0s
[11:30:22.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:138:0)
[11:30:22.446] Timer tick, asking Buildbucket for the build status
[11:30:22.593] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:22.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:139:0) after 1m0s
[11:31:22.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:139:0)
[11:31:22.782] Timer tick, asking Buildbucket for the build status
[11:31:23.088] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:23.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:140:0) after 1m0s
[11:32:23.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:140:0)
[11:32:23.178] Timer tick, asking Buildbucket for the build status
[11:32:27.418] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:27.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:141:0) after 1m0s
[11:33:27.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:141:0)
[11:33:27.538] Timer tick, asking Buildbucket for the build status
[11:33:27.875] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:27.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:142:0) after 1m0s
[11:34:27.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:142:0)
[11:34:27.942] Timer tick, asking Buildbucket for the build status
[11:34:28.148] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:28.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:143:0) after 1m0s
[11:35:28.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:143:0)
[11:35:28.185] Timer tick, asking Buildbucket for the build status
[11:35:28.640] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:28.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:144:0) after 1m0s
[11:36:28.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:144:0)
[11:36:28.770] Timer tick, asking Buildbucket for the build status
[11:36:29.082] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:29.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:145:0) after 1m0s
[11:37:29.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:145:0)
[11:37:29.212] Timer tick, asking Buildbucket for the build status
[11:37:30.259] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:30.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:146:0) after 1m0s
[11:38:30.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:146:0)
[11:38:30.261] Timer tick, asking Buildbucket for the build status
[11:38:32.906] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:32.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:147:0) after 1m0s
[11:39:32.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:147:0)
[11:39:32.932] Timer tick, asking Buildbucket for the build status
[11:39:33.067] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:33.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:148:0) after 1m0s
[11:40:33.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:148:0)
[11:40:33.122] Timer tick, asking Buildbucket for the build status
[11:40:33.272] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:33.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:149:0) after 1m0s
[11:41:33.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:149:0)
[11:41:33.303] Timer tick, asking Buildbucket for the build status
[11:41:33.736] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:33.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:150:0) after 1m0s
[11:42:33.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:150:0)
[11:42:33.769] Timer tick, asking Buildbucket for the build status
[11:42:33.932] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:33.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:151:0) after 1m0s
[11:43:34.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:151:0)
[11:43:34.002] Timer tick, asking Buildbucket for the build status
[11:43:34.221] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:34.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:152:0) after 1m0s
[11:44:34.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:152:0)
[11:44:34.339] Timer tick, asking Buildbucket for the build status
[11:44:34.581] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:34.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:153:0) after 1m0s
[11:45:34.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:153:0)
[11:45:34.611] Timer tick, asking Buildbucket for the build status
[11:45:34.839] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:34.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:154:0) after 1m0s
[11:46:34.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:154:0)
[11:46:34.860] Timer tick, asking Buildbucket for the build status
[11:46:35.058] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:35.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:155:0) after 1m0s
[11:47:35.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:155:0)
[11:47:35.154] Timer tick, asking Buildbucket for the build status
[11:47:35.338] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:35.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:156:0) after 1m0s
[11:48:35.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:156:0)
[11:48:35.478] Timer tick, asking Buildbucket for the build status
[11:48:35.767] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:35.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:157:0) after 1m0s
[11:49:35.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:157:0)
[11:49:35.898] Timer tick, asking Buildbucket for the build status
[11:49:36.020] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:36.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:158:0) after 1m0s
[11:50:36.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:158:0)
[11:50:36.102] Timer tick, asking Buildbucket for the build status
[11:50:36.285] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:36.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:159:0) after 1m0s
[11:51:36.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:159:0)
[11:51:36.323] Timer tick, asking Buildbucket for the build status
[11:51:36.434] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:36.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:160:0) after 1m0s
[11:52:36.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:160:0)
[11:52:36.576] Timer tick, asking Buildbucket for the build status
[11:52:36.715] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:36.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:161:0) after 1m0s
[11:53:36.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:161:0)
[11:53:36.786] Timer tick, asking Buildbucket for the build status
[11:53:37.521] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:37.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:162:0) after 1m0s
[11:54:37.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:162:0)
[11:54:37.587] Timer tick, asking Buildbucket for the build status
[11:54:38.678] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:38.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:163:0) after 1m0s
[11:55:38.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:163:0)
[11:55:38.718] Timer tick, asking Buildbucket for the build status
[11:55:39.001] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:39.001] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:164:0) after 1m0s
[11:56:39.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:164:0)
[11:56:39.057] Timer tick, asking Buildbucket for the build status
[11:56:39.889] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:39.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:165:0) after 1m0s
[11:57:39.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:165:0)
[11:57:39.918] Timer tick, asking Buildbucket for the build status
[11:57:40.109] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:40.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:166:0) after 1m0s
[11:58:40.171] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:166:0)
[11:58:40.171] Timer tick, asking Buildbucket for the build status
[11:58:40.961] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:40.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:167:0) after 1m0s
[11:59:41.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:167:0)
[11:59:41.056] Timer tick, asking Buildbucket for the build status
[11:59:41.628] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:41.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:168:0) after 1m0s
[12:00:41.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:168:0)
[12:00:41.723] Timer tick, asking Buildbucket for the build status
[12:00:42.059] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:42.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:169:0) after 1m0s
[12:01:42.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:169:0)
[12:01:42.088] Timer tick, asking Buildbucket for the build status
[12:01:42.267] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:42.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:170:0) after 1m0s
[12:02:42.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:170:0)
[12:02:42.355] Timer tick, asking Buildbucket for the build status
[12:02:42.507] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:42.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:171:0) after 1m0s
[12:03:42.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:171:0)
[12:03:42.572] Timer tick, asking Buildbucket for the build status
[12:03:47.488] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:47.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:172:0) after 1m0s
[12:04:47.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:172:0)
[12:04:47.513] Timer tick, asking Buildbucket for the build status
[12:04:47.707] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:47.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:173:0) after 1m0s
[12:05:47.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:173:0)
[12:05:47.767] Timer tick, asking Buildbucket for the build status
[12:05:47.970] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:47.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:174:0) after 1m0s
[12:06:47.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:174:0)
[12:06:47.998] Timer tick, asking Buildbucket for the build status
[12:06:48.430] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:48.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:175:0) after 1m0s
[12:07:48.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:175:0)
[12:07:48.465] Timer tick, asking Buildbucket for the build status
[12:07:48.594] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:48.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:176:0) after 1m0s
[12:08:48.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:176:0)
[12:08:48.691] Timer tick, asking Buildbucket for the build status
[12:08:50.092] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:50.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:177:0) after 1m0s
[12:09:50.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:177:0)
[12:09:50.187] Timer tick, asking Buildbucket for the build status
[12:09:50.654] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:50.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:178:0) after 1m0s
[12:10:50.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:178:0)
[12:10:50.751] Timer tick, asking Buildbucket for the build status
[12:10:50.955] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:50.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:179:0) after 1m0s
[12:11:51.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:179:0)
[12:11:51.149] Timer tick, asking Buildbucket for the build status
[12:11:51.854] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:51.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:180:0) after 1m0s
[12:12:51.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:180:0)
[12:12:51.945] Timer tick, asking Buildbucket for the build status
[12:12:52.281] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:52.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:181:0) after 1m0s
[12:13:52.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:181:0)
[12:13:52.301] Timer tick, asking Buildbucket for the build status
[12:13:57.862] Build 8882873839465308688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:57.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9048303901548961792:182:0) after 1m0s
[12:14:21.342] Received PubSub notification, asking Buildbucket for the build status
[12:14:21.542] Build 8882873839465308688: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:14:21.542] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1587039259910094",
    "created_by": "project:infra",
    "created_ts": "1587028385632139",
    "id": "8882873839465308688",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4115.4\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"c5147217-b870-40a6-a333-42b4b934754e\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4115.4\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4115.4\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"c5147217-b870-40a6-a333-42b4b934754e\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-ytni\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"84.0.4115.4\"}, \"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-ytni\"], \"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\": [\"4985-2a273fe\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1587029402417614",
    "status": "COMPLETED",
    "status_changed_ts": "1587039260744693",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9048303901548961792",
      "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/8882873839465308688/+/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:4b9b14e9c49fc510",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1587039260798389",
    "url": "https://ci.chromium.org/b/8882873839465308688",
    "utcnow_ts": "1587039261523344"
  }
}
[12:14:21.542] Invocation finished in 3h1m17.280219733s with status SUCCEEDED