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

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

{
  "version": "83.0.4103.106"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[20:23:40.565] New invocation is queued and will start shortly
[20:23:40.565] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[20:23:41.713] Starting the invocation (attempt 1)
[20:23:41.761] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:23:41.761] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:23:41.761] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9042825892760040080",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"83.0.4103.106\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"9e19a329-8faa-47bd-ba40-91d3992f9ee4\",\"title\":\"publish_tarball/0\"}]},\"version\":\"83.0.4103.106\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9042825892760040080",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[20:23:42.301] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1592252621889812",
    "id": "8877395830707988880",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4103.106\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9e19a329-8faa-47bd-ba40-91d3992f9ee4\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4103.106\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1592252622117698",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9042825892760040080",
      "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/8877395830707988880/+/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": "1592252622117851",
    "url": "https://ci.chromium.org/b/8877395830707988880",
    "utcnow_ts": "1592252622291398"
  }
}
[20:23:42.301] Task URL: https://ci.chromium.org/b/8877395830707988880
[20:23:42.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:2:0) after 1m0s
[20:24:42.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:2:0)
[20:24:42.320] Timer tick, asking Buildbucket for the build status
[20:24:42.506] Build 8877395830707988880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:24:42.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:3:0) after 1m0s
[20:25:42.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:3:0)
[20:25:42.604] Timer tick, asking Buildbucket for the build status
[20:25:42.848] Build 8877395830707988880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:25:42.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:4:0) after 1m0s
[20:26:42.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:4:0)
[20:26:42.867] Timer tick, asking Buildbucket for the build status
[20:26:43.197] Build 8877395830707988880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:26:43.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:5:0) after 1m0s
[20:27:43.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:5:0)
[20:27:43.245] Timer tick, asking Buildbucket for the build status
[20:27:48.882] Build 8877395830707988880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:27:48.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:6:0) after 1m0s
[20:28:49.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:6:0)
[20:28:49.036] Timer tick, asking Buildbucket for the build status
[20:28:49.285] Build 8877395830707988880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:49.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:7:0) after 1m0s
[20:29:49.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:7:0)
[20:29:49.353] Timer tick, asking Buildbucket for the build status
[20:29:49.686] Build 8877395830707988880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:29:49.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:8:0) after 1m0s
[20:30:49.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:8:0)
[20:30:49.765] Timer tick, asking Buildbucket for the build status
[20:30:49.951] Build 8877395830707988880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:30:49.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:9:0) after 1m0s
[20:31:50.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:9:0)
[20:31:50.012] Timer tick, asking Buildbucket for the build status
[20:31:50.198] Build 8877395830707988880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:50.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:10:0) after 1m0s
[20:32:50.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:10:0)
[20:32:50.560] Timer tick, asking Buildbucket for the build status
[20:32:50.758] Build 8877395830707988880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:32:50.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:11:0) after 1m0s
[20:33:50.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:11:0)
[20:33:50.807] Timer tick, asking Buildbucket for the build status
[20:33:51.022] Build 8877395830707988880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:33:51.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:12:0) after 1m0s
[20:34:51.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:12:0)
[20:34:51.172] Timer tick, asking Buildbucket for the build status
[20:34:51.381] Build 8877395830707988880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:34:51.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:13:0) after 1m0s
[20:35:51.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:13:0)
[20:35:51.542] Timer tick, asking Buildbucket for the build status
[20:35:51.716] Build 8877395830707988880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:35:51.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:14:0) after 1m0s
[20:36:51.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:14:0)
[20:36:51.749] Timer tick, asking Buildbucket for the build status
[20:36:52.018] Build 8877395830707988880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:36:52.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:15:0) after 1m0s
[20:37:52.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:15:0)
[20:37:52.145] Timer tick, asking Buildbucket for the build status
[20:37:52.462] Build 8877395830707988880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:37:52.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:16:0) after 1m0s
[20:38:24.703] Received PubSub notification, asking Buildbucket for the build status
[20:38:25.401] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:52.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:16:0)
[20:38:52.511] Timer tick, asking Buildbucket for the build status
[20:38:52.750] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:52.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:18:0) after 1m0s
[20:39:52.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:18:0)
[20:39:52.787] Timer tick, asking Buildbucket for the build status
[20:39:53.057] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:53.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:19:0) after 1m0s
[20:40:53.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:19:0)
[20:40:53.093] Timer tick, asking Buildbucket for the build status
[20:40:53.487] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:53.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:20:0) after 1m0s
[20:41:53.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:20:0)
[20:41:53.567] Timer tick, asking Buildbucket for the build status
[20:41:53.826] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:53.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:21:0) after 1m0s
[20:42:53.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:21:0)
[20:42:53.873] Timer tick, asking Buildbucket for the build status
[20:42:56.254] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:56.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:22:0) after 1m0s
[20:43:56.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:22:0)
[20:43:56.309] Timer tick, asking Buildbucket for the build status
[20:43:56.558] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:56.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:23:0) after 1m0s
[20:44:56.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:23:0)
[20:44:56.581] Timer tick, asking Buildbucket for the build status
[20:44:56.981] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:56.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:24:0) after 1m0s
[20:45:57.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:24:0)
[20:45:57.045] Timer tick, asking Buildbucket for the build status
[20:45:57.300] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:57.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:25:0) after 1m0s
[20:46:57.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:25:0)
[20:46:57.338] Timer tick, asking Buildbucket for the build status
[20:46:57.892] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:57.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:26:0) after 1m0s
[20:47:57.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:26:0)
[20:47:57.921] Timer tick, asking Buildbucket for the build status
[20:47:58.320] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:58.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:27:0) after 1m0s
[20:48:58.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:27:0)
[20:48:58.370] Timer tick, asking Buildbucket for the build status
[20:48:58.859] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:58.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:28:0) after 1m0s
[20:49:58.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:28:0)
[20:49:58.872] Timer tick, asking Buildbucket for the build status
[20:49:59.160] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:59.160] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:29:0) after 1m0s
[20:50:59.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:29:0)
[20:50:59.193] Timer tick, asking Buildbucket for the build status
[20:50:59.586] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:59.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:30:0) after 1m0s
[20:51:59.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:30:0)
[20:51:59.603] Timer tick, asking Buildbucket for the build status
[20:52:00.224] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:00.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:31:0) after 1m0s
[20:53:00.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:31:0)
[20:53:00.244] Timer tick, asking Buildbucket for the build status
[20:53:03.200] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:03.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:32:0) after 1m0s
[20:54:03.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:32:0)
[20:54:03.277] Timer tick, asking Buildbucket for the build status
[20:54:03.485] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:03.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:33:0) after 1m0s
[20:55:04.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:33:0)
[20:55:04.968] Timer tick, asking Buildbucket for the build status
[20:55:05.139] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:05.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:34:0) after 1m0s
[20:56:06.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:34:0)
[20:56:06.934] Timer tick, asking Buildbucket for the build status
[20:56:07.178] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:07.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:35:0) after 1m0s
[20:57:07.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:35:0)
[20:57:07.374] Timer tick, asking Buildbucket for the build status
[20:57:07.528] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:07.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:36:0) after 1m0s
[20:58:07.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:36:0)
[20:58:07.660] Timer tick, asking Buildbucket for the build status
[20:58:07.994] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:07.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:37:0) after 1m0s
[20:59:08.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:37:0)
[20:59:08.287] Timer tick, asking Buildbucket for the build status
[20:59:08.477] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:08.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:38:0) after 1m0s
[21:00:08.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:38:0)
[21:00:08.500] Timer tick, asking Buildbucket for the build status
[21:00:08.727] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:08.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:39:0) after 1m0s
[21:01:08.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:39:0)
[21:01:08.930] Timer tick, asking Buildbucket for the build status
[21:01:09.489] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:09.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:40:0) after 1m0s
[21:02:09.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:40:0)
[21:02:09.564] Timer tick, asking Buildbucket for the build status
[21:02:09.752] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:09.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:41:0) after 1m0s
[21:03:09.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:41:0)
[21:03:09.840] Timer tick, asking Buildbucket for the build status
[21:03:10.229] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:10.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:42:0) after 1m0s
[21:04:10.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:42:0)
[21:04:10.251] Timer tick, asking Buildbucket for the build status
[21:04:10.424] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:10.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:43:0) after 1m0s
[21:05:10.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:43:0)
[21:05:10.447] Timer tick, asking Buildbucket for the build status
[21:05:10.683] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:10.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:44:0) after 1m0s
[21:06:10.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:44:0)
[21:06:10.708] Timer tick, asking Buildbucket for the build status
[21:06:10.830] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:10.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:45:0) after 1m0s
[21:07:10.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:45:0)
[21:07:10.901] Timer tick, asking Buildbucket for the build status
[21:07:11.043] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:11.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:46:0) after 1m0s
[21:08:11.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:46:0)
[21:08:11.091] Timer tick, asking Buildbucket for the build status
[21:08:11.415] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:11.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:47:0) after 1m0s
[21:09:11.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:47:0)
[21:09:11.459] Timer tick, asking Buildbucket for the build status
[21:09:11.685] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:11.685] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:48:0) after 1m0s
[21:10:11.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:48:0)
[21:10:11.713] Timer tick, asking Buildbucket for the build status
[21:10:12.123] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:12.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:49:0) after 1m0s
[21:11:12.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:49:0)
[21:11:12.197] Timer tick, asking Buildbucket for the build status
[21:11:12.371] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:12.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:50:0) after 1m0s
[21:12:13.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:50:0)
[21:12:13.519] Timer tick, asking Buildbucket for the build status
[21:12:13.755] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:13.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:51:0) after 1m0s
[21:13:13.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:51:0)
[21:13:13.982] Timer tick, asking Buildbucket for the build status
[21:13:14.168] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:14.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:52:0) after 1m0s
[21:14:14.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:52:0)
[21:14:14.330] Timer tick, asking Buildbucket for the build status
[21:14:14.420] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:14.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:53:0) after 1m0s
[21:15:14.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:53:0)
[21:15:14.718] Timer tick, asking Buildbucket for the build status
[21:15:14.935] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:14.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:54:0) after 1m0s
[21:16:15.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:54:0)
[21:16:15.024] Timer tick, asking Buildbucket for the build status
[21:16:15.233] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:15.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:55:0) after 1m0s
[21:17:15.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:55:0)
[21:17:15.270] Timer tick, asking Buildbucket for the build status
[21:17:15.424] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:15.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:56:0) after 1m0s
[21:18:15.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:56:0)
[21:18:15.505] Timer tick, asking Buildbucket for the build status
[21:18:15.841] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:15.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:57:0) after 1m0s
[21:19:15.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:57:0)
[21:19:15.884] Timer tick, asking Buildbucket for the build status
[21:19:16.088] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:16.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:58:0) after 1m0s
[21:20:16.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:58:0)
[21:20:16.149] Timer tick, asking Buildbucket for the build status
[21:20:17.489] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:17.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:59:0) after 1m0s
[21:21:17.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:59:0)
[21:21:17.688] Timer tick, asking Buildbucket for the build status
[21:21:17.877] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:17.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:60:0) after 1m0s
[21:22:17.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:60:0)
[21:22:17.914] Timer tick, asking Buildbucket for the build status
[21:22:18.049] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:18.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:61:0) after 1m0s
[21:23:18.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:61:0)
[21:23:18.078] Timer tick, asking Buildbucket for the build status
[21:23:18.193] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:18.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:62:0) after 1m0s
[21:24:18.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:62:0)
[21:24:18.233] Timer tick, asking Buildbucket for the build status
[21:24:18.586] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:18.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:63:0) after 1m0s
[21:25:18.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:63:0)
[21:25:18.589] Timer tick, asking Buildbucket for the build status
[21:25:18.725] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:18.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:64:0) after 1m0s
[21:26:18.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:64:0)
[21:26:18.763] Timer tick, asking Buildbucket for the build status
[21:26:19.249] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:19.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:65:0) after 1m0s
[21:27:19.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:65:0)
[21:27:19.328] Timer tick, asking Buildbucket for the build status
[21:27:20.838] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:20.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:66:0) after 1m0s
[21:28:20.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:66:0)
[21:28:20.934] Timer tick, asking Buildbucket for the build status
[21:28:22.400] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:22.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:67:0) after 1m0s
[21:29:22.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:67:0)
[21:29:22.440] Timer tick, asking Buildbucket for the build status
[21:29:22.725] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:22.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:68:0) after 1m0s
[21:30:22.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:68:0)
[21:30:22.837] Timer tick, asking Buildbucket for the build status
[21:30:23.045] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:23.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:69:0) after 1m0s
[21:31:23.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:69:0)
[21:31:23.157] Timer tick, asking Buildbucket for the build status
[21:31:23.434] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:23.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:70:0) after 1m0s
[21:32:23.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:70:0)
[21:32:23.608] Timer tick, asking Buildbucket for the build status
[21:32:24.240] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:24.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:71:0) after 1m0s
[21:33:24.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:71:0)
[21:33:24.292] Timer tick, asking Buildbucket for the build status
[21:33:24.650] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:24.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:72:0) after 1m0s
[21:34:24.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:72:0)
[21:34:24.719] Timer tick, asking Buildbucket for the build status
[21:34:24.870] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:24.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:73:0) after 1m0s
[21:35:24.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:73:0)
[21:35:24.913] Timer tick, asking Buildbucket for the build status
[21:35:24.976] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:24.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:74:0) after 1m0s
[21:36:25.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:74:0)
[21:36:25.042] Timer tick, asking Buildbucket for the build status
[21:36:25.386] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:25.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:75:0) after 1m0s
[21:37:25.456] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:75:0)
[21:37:25.456] Timer tick, asking Buildbucket for the build status
[21:37:25.618] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:25.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:76:0) after 1m0s
[21:38:25.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:76:0)
[21:38:25.728] Timer tick, asking Buildbucket for the build status
[21:38:26.163] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:26.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:77:0) after 1m0s
[21:39:26.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:77:0)
[21:39:26.231] Timer tick, asking Buildbucket for the build status
[21:39:26.413] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:26.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:78:0) after 1m0s
[21:40:26.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:78:0)
[21:40:26.556] Timer tick, asking Buildbucket for the build status
[21:40:26.667] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:26.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:79:0) after 1m0s
[21:41:26.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:79:0)
[21:41:26.782] Timer tick, asking Buildbucket for the build status
[21:41:26.925] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:26.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:80:0) after 1m0s
[21:42:26.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:80:0)
[21:42:26.954] Timer tick, asking Buildbucket for the build status
[21:42:27.166] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:27.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:81:0) after 1m0s
[21:43:27.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:81:0)
[21:43:27.288] Timer tick, asking Buildbucket for the build status
[21:43:27.669] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:27.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:82:0) after 1m0s
[21:44:27.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:82:0)
[21:44:27.728] Timer tick, asking Buildbucket for the build status
[21:44:28.108] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:28.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:83:0) after 1m0s
[21:45:28.136] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:83:0)
[21:45:28.136] Timer tick, asking Buildbucket for the build status
[21:45:28.458] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:28.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:84:0) after 1m0s
[21:46:28.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:84:0)
[21:46:28.478] Timer tick, asking Buildbucket for the build status
[21:46:28.827] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:28.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:85:0) after 1m0s
[21:47:28.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:85:0)
[21:47:28.879] Timer tick, asking Buildbucket for the build status
[21:47:29.325] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:29.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:86:0) after 1m0s
[21:48:29.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:86:0)
[21:48:29.382] Timer tick, asking Buildbucket for the build status
[21:48:29.776] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:29.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:87:0) after 1m0s
[21:49:29.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:87:0)
[21:49:29.801] Timer tick, asking Buildbucket for the build status
[21:49:30.047] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:30.047] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:88:0) after 1m0s
[21:50:30.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:88:0)
[21:50:30.117] Timer tick, asking Buildbucket for the build status
[21:50:30.261] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:30.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:89:0) after 1m0s
[21:51:30.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:89:0)
[21:51:30.385] Timer tick, asking Buildbucket for the build status
[21:51:30.520] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:30.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:90:0) after 1m0s
[21:52:30.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:90:0)
[21:52:30.872] Timer tick, asking Buildbucket for the build status
[21:52:31.405] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:31.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:91:0) after 1m0s
[21:53:31.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:91:0)
[21:53:31.428] Timer tick, asking Buildbucket for the build status
[21:53:31.673] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:31.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:92:0) after 1m0s
[21:54:31.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:92:0)
[21:54:31.794] Timer tick, asking Buildbucket for the build status
[21:54:31.911] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:31.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:93:0) after 1m0s
[21:55:32.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:93:0)
[21:55:32.059] Timer tick, asking Buildbucket for the build status
[21:55:32.208] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:32.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:94:0) after 1m0s
[21:56:32.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:94:0)
[21:56:32.339] Timer tick, asking Buildbucket for the build status
[21:56:32.440] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:32.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:95:0) after 1m0s
[21:57:32.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:95:0)
[21:57:32.495] Timer tick, asking Buildbucket for the build status
[21:57:32.745] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:32.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:96:0) after 1m0s
[21:58:32.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:96:0)
[21:58:32.867] Timer tick, asking Buildbucket for the build status
[21:58:33.291] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:33.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:97:0) after 1m0s
[21:59:33.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:97:0)
[21:59:33.348] Timer tick, asking Buildbucket for the build status
[21:59:33.592] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:33.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:98:0) after 1m0s
[22:00:33.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:98:0)
[22:00:33.659] Timer tick, asking Buildbucket for the build status
[22:00:33.907] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:33.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:99:0) after 1m0s
[22:01:33.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:99:0)
[22:01:33.939] Timer tick, asking Buildbucket for the build status
[22:01:34.148] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:34.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:100:0) after 1m0s
[22:02:34.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:100:0)
[22:02:34.232] Timer tick, asking Buildbucket for the build status
[22:02:38.388] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:38.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:101:0) after 1m0s
[22:03:38.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:101:0)
[22:03:38.450] Timer tick, asking Buildbucket for the build status
[22:03:38.573] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:38.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:102:0) after 1m0s
[22:04:38.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:102:0)
[22:04:38.653] Timer tick, asking Buildbucket for the build status
[22:04:39.144] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:39.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:103:0) after 1m0s
[22:05:39.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:103:0)
[22:05:39.179] Timer tick, asking Buildbucket for the build status
[22:05:39.539] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:39.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:104:0) after 1m0s
[22:06:39.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:104:0)
[22:06:39.565] Timer tick, asking Buildbucket for the build status
[22:06:39.733] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:39.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:105:0) after 1m0s
[22:07:39.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:105:0)
[22:07:39.760] Timer tick, asking Buildbucket for the build status
[22:07:40.748] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:40.748] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:106:0) after 1m0s
[22:08:40.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:106:0)
[22:08:40.903] Timer tick, asking Buildbucket for the build status
[22:08:41.031] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:41.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:107:0) after 1m0s
[22:09:41.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:107:0)
[22:09:41.316] Timer tick, asking Buildbucket for the build status
[22:09:41.414] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:41.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:108:0) after 1m0s
[22:10:41.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:108:0)
[22:10:41.511] Timer tick, asking Buildbucket for the build status
[22:10:41.952] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:41.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:109:0) after 1m0s
[22:11:42.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:109:0)
[22:11:42.274] Timer tick, asking Buildbucket for the build status
[22:11:42.393] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:42.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:110:0) after 1m0s
[22:12:42.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:110:0)
[22:12:42.733] Timer tick, asking Buildbucket for the build status
[22:12:44.833] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:44.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:111:0) after 1m0s
[22:13:45.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:111:0)
[22:13:45.012] Timer tick, asking Buildbucket for the build status
[22:13:45.186] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:45.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:112:0) after 1m0s
[22:14:45.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:112:0)
[22:14:45.273] Timer tick, asking Buildbucket for the build status
[22:14:45.337] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:45.337] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:113:0) after 1m0s
[22:15:45.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:113:0)
[22:15:45.394] Timer tick, asking Buildbucket for the build status
[22:15:45.525] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:45.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:114:0) after 1m0s
[22:16:45.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:114:0)
[22:16:45.696] Timer tick, asking Buildbucket for the build status
[22:16:45.920] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:45.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:115:0) after 1m0s
[22:17:46.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:115:0)
[22:17:46.013] Timer tick, asking Buildbucket for the build status
[22:17:46.193] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:46.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:116:0) after 1m0s
[22:18:46.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:116:0)
[22:18:46.253] Timer tick, asking Buildbucket for the build status
[22:18:46.558] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:46.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:117:0) after 1m0s
[22:19:46.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:117:0)
[22:19:46.702] Timer tick, asking Buildbucket for the build status
[22:19:46.848] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:46.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:118:0) after 1m0s
[22:20:47.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:118:0)
[22:20:47.341] Timer tick, asking Buildbucket for the build status
[22:20:47.504] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:47.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:119:0) after 1m0s
[22:21:47.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:119:0)
[22:21:47.582] Timer tick, asking Buildbucket for the build status
[22:21:47.813] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:47.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:120:0) after 1m0s
[22:22:48.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:120:0)
[22:22:48.046] Timer tick, asking Buildbucket for the build status
[22:22:50.940] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:50.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:121:0) after 1m0s
[22:23:51.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:121:0)
[22:23:51.005] Timer tick, asking Buildbucket for the build status
[22:23:51.215] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:51.215] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:122:0) after 1m0s
[22:24:51.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:122:0)
[22:24:51.450] Timer tick, asking Buildbucket for the build status
[22:24:51.598] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:51.598] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:123:0) after 1m0s
[22:25:51.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:123:0)
[22:25:51.628] Timer tick, asking Buildbucket for the build status
[22:25:51.802] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:51.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:124:0) after 1m0s
[22:26:51.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:124:0)
[22:26:51.807] Timer tick, asking Buildbucket for the build status
[22:26:51.977] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:51.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:125:0) after 1m0s
[22:27:52.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:125:0)
[22:27:52.094] Timer tick, asking Buildbucket for the build status
[22:28:00.709] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:00.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:126:0) after 1m0s
[22:29:01.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:126:0)
[22:29:01.094] Timer tick, asking Buildbucket for the build status
[22:29:01.187] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:01.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:127:0) after 1m0s
[22:30:01.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:127:0)
[22:30:01.818] Timer tick, asking Buildbucket for the build status
[22:30:02.092] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:02.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:128:0) after 1m0s
[22:31:02.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:128:0)
[22:31:02.301] Timer tick, asking Buildbucket for the build status
[22:31:02.615] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:02.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:129:0) after 1m0s
[22:32:02.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:129:0)
[22:32:02.949] Timer tick, asking Buildbucket for the build status
[22:32:04.083] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:04.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:130:0) after 1m0s
[22:33:04.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:130:0)
[22:33:04.256] Timer tick, asking Buildbucket for the build status
[22:33:06.431] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:06.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:131:0) after 1m0s
[22:34:06.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:131:0)
[22:34:06.613] Timer tick, asking Buildbucket for the build status
[22:34:06.859] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:06.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:132:0) after 1m0s
[22:35:06.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:132:0)
[22:35:06.961] Timer tick, asking Buildbucket for the build status
[22:35:07.268] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:07.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:133:0) after 1m0s
[22:36:07.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:133:0)
[22:36:07.319] Timer tick, asking Buildbucket for the build status
[22:36:07.477] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:07.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:134:0) after 1m0s
[22:37:07.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:134:0)
[22:37:07.453] Timer tick, asking Buildbucket for the build status
[22:37:07.601] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:07.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:135:0) after 1m0s
[22:38:07.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:135:0)
[22:38:07.645] Timer tick, asking Buildbucket for the build status
[22:38:08.119] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:08.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:136:0) after 1m0s
[22:39:08.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:136:0)
[22:39:08.248] Timer tick, asking Buildbucket for the build status
[22:39:08.862] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:08.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:137:0) after 1m0s
[22:40:09.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:137:0)
[22:40:09.062] Timer tick, asking Buildbucket for the build status
[22:40:09.429] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:09.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:138:0) after 1m0s
[22:41:09.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:138:0)
[22:41:09.487] Timer tick, asking Buildbucket for the build status
[22:41:09.677] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:09.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:139:0) after 1m0s
[22:42:09.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:139:0)
[22:42:09.730] Timer tick, asking Buildbucket for the build status
[22:42:09.904] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:09.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:140:0) after 1m0s
[22:43:10.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:140:0)
[22:43:10.011] Timer tick, asking Buildbucket for the build status
[22:43:10.212] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:10.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:141:0) after 1m0s
[22:44:10.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:141:0)
[22:44:10.469] Timer tick, asking Buildbucket for the build status
[22:44:11.154] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:11.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:142:0) after 1m0s
[22:45:11.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:142:0)
[22:45:11.418] Timer tick, asking Buildbucket for the build status
[22:45:11.683] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:11.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:143:0) after 1m0s
[22:46:11.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:143:0)
[22:46:11.744] Timer tick, asking Buildbucket for the build status
[22:46:12.138] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:12.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:144:0) after 1m0s
[22:47:12.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:144:0)
[22:47:12.244] Timer tick, asking Buildbucket for the build status
[22:47:12.472] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:12.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:145:0) after 1m0s
[22:48:12.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:145:0)
[22:48:12.696] Timer tick, asking Buildbucket for the build status
[22:48:12.918] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:12.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:146:0) after 1m0s
[22:49:13.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:146:0)
[22:49:13.139] Timer tick, asking Buildbucket for the build status
[22:49:13.277] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:13.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:147:0) after 1m0s
[22:50:13.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:147:0)
[22:50:13.677] Timer tick, asking Buildbucket for the build status
[22:50:14.646] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:14.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:148:0) after 1m0s
[22:51:14.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:148:0)
[22:51:14.823] Timer tick, asking Buildbucket for the build status
[22:51:15.003] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:15.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:149:0) after 1m0s
[22:52:15.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:149:0)
[22:52:15.033] Timer tick, asking Buildbucket for the build status
[22:52:15.212] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:15.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:150:0) after 1m0s
[22:53:15.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:150:0)
[22:53:15.337] Timer tick, asking Buildbucket for the build status
[22:53:15.594] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:15.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:151:0) after 1m0s
[22:54:15.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:151:0)
[22:54:15.657] Timer tick, asking Buildbucket for the build status
[22:54:15.809] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:15.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:152:0) after 1m0s
[22:55:15.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:152:0)
[22:55:15.927] Timer tick, asking Buildbucket for the build status
[22:55:16.182] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:16.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:153:0) after 1m0s
[22:56:16.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:153:0)
[22:56:16.395] Timer tick, asking Buildbucket for the build status
[22:56:16.774] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:16.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:154:0) after 1m0s
[22:57:17.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:154:0)
[22:57:17.182] Timer tick, asking Buildbucket for the build status
[22:57:17.306] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:17.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:155:0) after 1m0s
[22:58:17.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:155:0)
[22:58:17.350] Timer tick, asking Buildbucket for the build status
[22:58:17.472] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:17.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:156:0) after 1m0s
[22:59:17.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:156:0)
[22:59:17.657] Timer tick, asking Buildbucket for the build status
[22:59:17.925] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:17.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:157:0) after 1m0s
[23:00:17.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:157:0)
[23:00:17.957] Timer tick, asking Buildbucket for the build status
[23:00:18.130] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:18.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:158:0) after 1m0s
[23:01:18.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:158:0)
[23:01:18.133] Timer tick, asking Buildbucket for the build status
[23:01:18.493] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:18.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:159:0) after 1m0s
[23:02:18.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:159:0)
[23:02:18.564] Timer tick, asking Buildbucket for the build status
[23:02:19.104] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:19.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:160:0) after 1m0s
[23:03:19.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:160:0)
[23:03:19.208] Timer tick, asking Buildbucket for the build status
[23:03:19.783] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:19.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:161:0) after 1m0s
[23:04:19.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:161:0)
[23:04:19.840] Timer tick, asking Buildbucket for the build status
[23:04:20.194] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:20.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:162:0) after 1m0s
[23:05:20.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:162:0)
[23:05:20.216] Timer tick, asking Buildbucket for the build status
[23:05:20.424] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:20.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:163:0) after 1m0s
[23:06:20.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:163:0)
[23:06:20.458] Timer tick, asking Buildbucket for the build status
[23:06:20.612] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:20.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:164:0) after 1m0s
[23:07:20.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:164:0)
[23:07:20.641] Timer tick, asking Buildbucket for the build status
[23:07:21.226] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:21.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:165:0) after 1m0s
[23:08:21.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:165:0)
[23:08:21.252] Timer tick, asking Buildbucket for the build status
[23:08:21.388] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:21.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:166:0) after 1m0s
[23:09:21.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:166:0)
[23:09:21.453] Timer tick, asking Buildbucket for the build status
[23:09:21.599] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:21.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:167:0) after 1m0s
[23:10:21.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:167:0)
[23:10:21.624] Timer tick, asking Buildbucket for the build status
[23:10:21.844] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:21.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:168:0) after 1m0s
[23:11:21.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:168:0)
[23:11:21.889] Timer tick, asking Buildbucket for the build status
[23:11:21.993] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:21.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:169:0) after 1m0s
[23:12:22.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:169:0)
[23:12:22.096] Timer tick, asking Buildbucket for the build status
[23:12:22.254] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:22.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:170:0) after 1m0s
[23:13:22.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:170:0)
[23:13:22.306] Timer tick, asking Buildbucket for the build status
[23:13:22.496] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:22.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:171:0) after 1m0s
[23:14:22.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:171:0)
[23:14:22.594] Timer tick, asking Buildbucket for the build status
[23:14:22.738] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:22.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:172:0) after 1m0s
[23:15:22.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:172:0)
[23:15:22.848] Timer tick, asking Buildbucket for the build status
[23:15:23.242] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:23.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:173:0) after 1m0s
[23:16:23.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:173:0)
[23:16:23.367] Timer tick, asking Buildbucket for the build status
[23:16:23.501] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:23.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:174:0) after 1m0s
[23:17:23.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:174:0)
[23:17:23.813] Timer tick, asking Buildbucket for the build status
[23:17:25.485] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:25.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:175:0) after 1m0s
[23:18:25.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:175:0)
[23:18:25.597] Timer tick, asking Buildbucket for the build status
[23:18:26.012] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:26.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:176:0) after 1m0s
[23:19:26.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:176:0)
[23:19:26.736] Timer tick, asking Buildbucket for the build status
[23:19:26.861] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:26.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:177:0) after 1m0s
[23:20:27.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:177:0)
[23:20:27.127] Timer tick, asking Buildbucket for the build status
[23:20:27.255] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:27.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:178:0) after 1m0s
[23:21:27.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:178:0)
[23:21:27.324] Timer tick, asking Buildbucket for the build status
[23:21:27.475] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:27.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:179:0) after 1m0s
[23:22:27.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:179:0)
[23:22:27.695] Timer tick, asking Buildbucket for the build status
[23:22:28.360] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:28.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:180:0) after 1m0s
[23:23:28.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:180:0)
[23:23:28.649] Timer tick, asking Buildbucket for the build status
[23:23:29.100] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:29.100] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:181:0) after 1m0s
[23:24:29.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:181:0)
[23:24:29.234] Timer tick, asking Buildbucket for the build status
[23:24:29.461] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:29.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:182:0) after 1m0s
[23:25:29.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:182:0)
[23:25:29.530] Timer tick, asking Buildbucket for the build status
[23:25:29.768] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:29.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:183:0) after 1m0s
[23:26:29.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:183:0)
[23:26:29.908] Timer tick, asking Buildbucket for the build status
[23:26:30.276] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:30.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:184:0) after 1m0s
[23:27:30.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:184:0)
[23:27:30.306] Timer tick, asking Buildbucket for the build status
[23:27:33.417] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:33.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:185:0) after 1m0s
[23:28:33.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:185:0)
[23:28:33.569] Timer tick, asking Buildbucket for the build status
[23:28:33.701] Build 8877395830707988880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:33.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042825892760040080:186:0) after 1m0s
[23:28:40.086] Received PubSub notification, asking Buildbucket for the build status
[23:28:40.234] Build 8877395830707988880: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:28:40.234] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1592263718561045",
    "created_by": "project:infra",
    "created_ts": "1592252621889812",
    "id": "8877395830707988880",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4103.106\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9e19a329-8faa-47bd-ba40-91d3992f9ee4\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4103.106\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_292036ca8cd0711903e829a3c5417e821d204af08fdef2e4b6d3affbee40eeb2_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-eht0\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5207-21acfae\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1592253496489948",
    "status": "COMPLETED",
    "status_changed_ts": "1592263719440610",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9042825892760040080",
      "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/8877395830707988880/+/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:4cd27876a0aca410",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1592263719553960",
    "url": "https://ci.chromium.org/b/8877395830707988880",
    "utcnow_ts": "1592263720216250"
  }
}
[23:28:40.234] Invocation finished in 3h4m59.684237777s with status SUCCEEDED