LUCI Scheduler :: infra :: Build From Tarball

Status: FAILED

Triggered by: chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com

Duration: 3 hours

Actions:

Definition (rev ef1333c7bf2cf95d15a0ce92acf83d24bcd6c5ac)

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

Incoming triggers

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

Incoming properties

{
  "version": "78.0.3904.2"
}

Incoming tags

parent_buildername:publish_tarball
user_agent:recipe

Debug log (UTC)

[23:41:24.633] New invocation is queued and will start shortly
[23:41:24.633] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[23:41:25.793] Starting the invocation (attempt 1)
[23:41:25.831] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:41:25.831] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:41:25.831] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9068452393877593968",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"78.0.3904.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"0087416e-ba5b-467e-b3b9-1f4a84aaba62\",\"title\":\"publish_tarball/0\"}]},\"version\":\"78.0.3904.2\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9068452393877593968",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[23:41:26.519] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1567813285982396",
    "id": "8903022331796279568",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"78.0.3904.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"0087416e-ba5b-467e-b3b9-1f4a84aaba62\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"78.0.3904.2\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1567813286328714",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9068452393877593968",
      "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/8903022331796279568/+/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": "1567813286328870",
    "url": "https://ci.chromium.org/b/8903022331796279568",
    "utcnow_ts": "1567813286492724"
  }
}
[23:41:26.519] Task URL: https://ci.chromium.org/b/8903022331796279568
[23:41:26.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:2:0) after 1m0s
[23:42:26.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:2:0)
[23:42:26.681] Timer tick, asking Buildbucket for the build status
[23:42:26.796] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:26.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:3:0) after 1m0s
[23:43:26.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:3:0)
[23:43:26.958] Timer tick, asking Buildbucket for the build status
[23:43:27.706] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:27.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:4:0) after 1m0s
[23:44:27.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:4:0)
[23:44:27.816] Timer tick, asking Buildbucket for the build status
[23:44:28.333] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:28.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:5:0) after 1m0s
[23:45:28.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:5:0)
[23:45:28.356] Timer tick, asking Buildbucket for the build status
[23:45:28.733] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:28.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:6:0) after 1m0s
[23:46:28.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:6:0)
[23:46:28.804] Timer tick, asking Buildbucket for the build status
[23:46:28.922] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:28.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:7:0) after 1m0s
[23:47:28.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:7:0)
[23:47:28.931] Timer tick, asking Buildbucket for the build status
[23:47:29.836] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:29.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:8:0) after 1m0s
[23:48:29.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:8:0)
[23:48:29.873] Timer tick, asking Buildbucket for the build status
[23:48:30.095] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:30.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:9:0) after 1m0s
[23:49:30.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:9:0)
[23:49:30.237] Timer tick, asking Buildbucket for the build status
[23:49:30.546] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:30.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:10:0) after 1m0s
[23:50:30.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:10:0)
[23:50:30.602] Timer tick, asking Buildbucket for the build status
[23:50:30.703] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:30.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:11:0) after 1m0s
[23:51:30.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:11:0)
[23:51:30.698] Timer tick, asking Buildbucket for the build status
[23:51:30.909] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:30.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:12:0) after 1m0s
[23:52:30.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:12:0)
[23:52:30.933] Timer tick, asking Buildbucket for the build status
[23:52:33.513] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:33.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:13:0) after 1m0s
[23:53:33.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:13:0)
[23:53:33.599] Timer tick, asking Buildbucket for the build status
[23:53:33.748] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:33.748] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:14:0) after 1m0s
[23:54:33.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:14:0)
[23:54:33.747] Timer tick, asking Buildbucket for the build status
[23:54:33.841] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:33.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:15:0) after 1m0s
[23:55:33.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:15:0)
[23:55:33.956] Timer tick, asking Buildbucket for the build status
[23:55:34.624] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:34.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:16:0) after 1m0s
[23:56:34.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:16:0)
[23:56:34.656] Timer tick, asking Buildbucket for the build status
[23:56:35.006] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:35.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:17:0) after 1m0s
[23:57:35.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:17:0)
[23:57:35.078] Timer tick, asking Buildbucket for the build status
[23:57:35.809] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:35.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:18:0) after 1m0s
[23:58:35.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:18:0)
[23:58:35.977] Timer tick, asking Buildbucket for the build status
[23:58:36.079] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:36.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:19:0) after 1m0s
[23:59:36.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:19:0)
[23:59:36.089] Timer tick, asking Buildbucket for the build status
[23:59:36.389] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:36.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:20:0) after 1m0s
[00:00:36.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:20:0)
[00:00:36.470] Timer tick, asking Buildbucket for the build status
[00:00:36.569] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:36.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:21:0) after 1m0s
[00:01:36.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:21:0)
[00:01:36.637] Timer tick, asking Buildbucket for the build status
[00:01:37.131] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:37.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:22:0) after 1m0s
[00:02:37.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:22:0)
[00:02:37.157] Timer tick, asking Buildbucket for the build status
[00:02:37.344] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:37.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:23:0) after 1m0s
[00:03:37.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:23:0)
[00:03:37.368] Timer tick, asking Buildbucket for the build status
[00:03:37.843] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:37.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:24:0) after 1m0s
[00:04:37.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:24:0)
[00:04:37.885] Timer tick, asking Buildbucket for the build status
[00:04:38.763] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:38.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:25:0) after 1m0s
[00:05:38.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:25:0)
[00:05:38.787] Timer tick, asking Buildbucket for the build status
[00:05:39.353] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:39.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:26:0) after 1m0s
[00:06:39.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:26:0)
[00:06:39.382] Timer tick, asking Buildbucket for the build status
[00:06:39.531] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:39.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:27:0) after 1m0s
[00:07:39.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:27:0)
[00:07:39.578] Timer tick, asking Buildbucket for the build status
[00:07:39.881] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:39.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:28:0) after 1m0s
[00:08:39.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:28:0)
[00:08:39.940] Timer tick, asking Buildbucket for the build status
[00:08:40.542] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:40.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:29:0) after 1m0s
[00:09:40.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:29:0)
[00:09:40.622] Timer tick, asking Buildbucket for the build status
[00:09:41.008] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:41.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:30:0) after 1m0s
[00:10:41.080] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:30:0)
[00:10:41.080] Timer tick, asking Buildbucket for the build status
[00:10:42.306] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:42.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:31:0) after 1m0s
[00:11:42.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:31:0)
[00:11:42.333] Timer tick, asking Buildbucket for the build status
[00:11:43.142] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:43.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:32:0) after 1m0s
[00:12:43.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:32:0)
[00:12:43.146] Timer tick, asking Buildbucket for the build status
[00:12:43.407] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:43.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:33:0) after 1m0s
[00:13:43.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:33:0)
[00:13:43.465] Timer tick, asking Buildbucket for the build status
[00:13:44.813] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:44.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:34:0) after 1m0s
[00:14:45.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:34:0)
[00:14:45.060] Timer tick, asking Buildbucket for the build status
[00:14:45.487] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:45.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:35:0) after 1m0s
[00:15:45.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:35:0)
[00:15:45.733] Timer tick, asking Buildbucket for the build status
[00:15:47.305] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:47.305] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:36:0) after 1m0s
[00:16:47.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:36:0)
[00:16:47.423] Timer tick, asking Buildbucket for the build status
[00:16:48.574] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:48.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:37:0) after 1m0s
[00:17:48.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:37:0)
[00:17:48.644] Timer tick, asking Buildbucket for the build status
[00:17:48.880] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:48.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:38:0) after 1m0s
[00:18:48.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:38:0)
[00:18:48.858] Timer tick, asking Buildbucket for the build status
[00:18:49.448] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:49.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:39:0) after 1m0s
[00:19:49.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:39:0)
[00:19:49.503] Timer tick, asking Buildbucket for the build status
[00:19:49.699] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:49.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:40:0) after 1m0s
[00:20:49.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:40:0)
[00:20:49.778] Timer tick, asking Buildbucket for the build status
[00:20:50.709] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:50.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:41:0) after 1m0s
[00:21:50.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:41:0)
[00:21:50.740] Timer tick, asking Buildbucket for the build status
[00:21:50.924] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:50.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:42:0) after 1m0s
[00:22:51.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:42:0)
[00:22:51.002] Timer tick, asking Buildbucket for the build status
[00:22:51.238] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:51.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:43:0) after 1m0s
[00:23:51.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:43:0)
[00:23:51.277] Timer tick, asking Buildbucket for the build status
[00:23:51.484] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:51.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:44:0) after 1m0s
[00:24:51.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:44:0)
[00:24:51.513] Timer tick, asking Buildbucket for the build status
[00:24:51.792] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:51.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:45:0) after 1m0s
[00:25:51.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:45:0)
[00:25:51.819] Timer tick, asking Buildbucket for the build status
[00:25:52.107] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:52.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:46:0) after 1m0s
[00:26:52.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:46:0)
[00:26:52.221] Timer tick, asking Buildbucket for the build status
[00:26:52.431] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:52.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:47:0) after 1m0s
[00:27:52.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:47:0)
[00:27:52.452] Timer tick, asking Buildbucket for the build status
[00:27:54.386] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:54.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:48:0) after 1m0s
[00:28:54.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:48:0)
[00:28:54.421] Timer tick, asking Buildbucket for the build status
[00:28:54.618] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:54.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:49:0) after 1m0s
[00:29:54.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:49:0)
[00:29:54.640] Timer tick, asking Buildbucket for the build status
[00:29:54.903] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:54.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:50:0) after 1m0s
[00:30:55.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:50:0)
[00:30:55.024] Timer tick, asking Buildbucket for the build status
[00:30:55.171] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:55.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:51:0) after 1m0s
[00:31:55.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:51:0)
[00:31:55.516] Timer tick, asking Buildbucket for the build status
[00:31:55.826] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:55.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:52:0) after 1m0s
[00:32:56.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:52:0)
[00:32:56.215] Timer tick, asking Buildbucket for the build status
[00:32:56.694] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:56.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:53:0) after 1m0s
[00:33:56.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:53:0)
[00:33:56.869] Timer tick, asking Buildbucket for the build status
[00:33:57.197] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:57.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:54:0) after 1m0s
[00:34:57.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:54:0)
[00:34:57.350] Timer tick, asking Buildbucket for the build status
[00:34:57.495] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:57.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:55:0) after 1m0s
[00:35:57.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:55:0)
[00:35:57.622] Timer tick, asking Buildbucket for the build status
[00:35:58.031] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:58.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:56:0) after 1m0s
[00:36:58.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:56:0)
[00:36:58.104] Timer tick, asking Buildbucket for the build status
[00:36:59.289] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:59.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:57:0) after 1m0s
[00:37:59.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:57:0)
[00:37:59.351] Timer tick, asking Buildbucket for the build status
[00:38:00.992] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:00.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:58:0) after 1m0s
[00:39:01.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:58:0)
[00:39:01.156] Timer tick, asking Buildbucket for the build status
[00:39:01.456] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:01.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:59:0) after 1m0s
[00:40:01.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:59:0)
[00:40:01.556] Timer tick, asking Buildbucket for the build status
[00:40:01.933] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:01.933] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:60:0) after 1m0s
[00:41:02.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:60:0)
[00:41:02.045] Timer tick, asking Buildbucket for the build status
[00:41:02.371] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:02.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:61:0) after 1m0s
[00:42:02.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:61:0)
[00:42:02.460] Timer tick, asking Buildbucket for the build status
[00:42:02.885] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:02.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:62:0) after 1m0s
[00:43:03.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:62:0)
[00:43:03.041] Timer tick, asking Buildbucket for the build status
[00:43:03.662] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:03.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:63:0) after 1m0s
[00:44:03.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:63:0)
[00:44:03.726] Timer tick, asking Buildbucket for the build status
[00:44:04.065] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:04.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:64:0) after 1m0s
[00:45:04.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:64:0)
[00:45:04.095] Timer tick, asking Buildbucket for the build status
[00:45:05.125] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:05.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:65:0) after 1m0s
[00:46:05.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:65:0)
[00:46:05.215] Timer tick, asking Buildbucket for the build status
[00:46:05.372] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:05.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:66:0) after 1m0s
[00:47:05.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:66:0)
[00:47:05.416] Timer tick, asking Buildbucket for the build status
[00:47:06.713] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:06.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:67:0) after 1m0s
[00:48:06.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:67:0)
[00:48:06.733] Timer tick, asking Buildbucket for the build status
[00:48:07.032] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:07.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:68:0) after 1m0s
[00:49:07.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:68:0)
[00:49:07.063] Timer tick, asking Buildbucket for the build status
[00:49:08.413] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:08.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:69:0) after 1m0s
[00:50:08.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:69:0)
[00:50:08.488] Timer tick, asking Buildbucket for the build status
[00:50:08.612] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:08.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:70:0) after 1m0s
[00:51:08.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:70:0)
[00:51:08.638] Timer tick, asking Buildbucket for the build status
[00:51:09.151] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:09.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:71:0) after 1m0s
[00:52:09.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:71:0)
[00:52:09.208] Timer tick, asking Buildbucket for the build status
[00:52:09.993] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:09.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:72:0) after 1m0s
[00:53:10.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:72:0)
[00:53:10.049] Timer tick, asking Buildbucket for the build status
[00:53:10.231] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:10.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:73:0) after 1m0s
[00:54:10.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:73:0)
[00:54:10.254] Timer tick, asking Buildbucket for the build status
[00:54:10.631] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:10.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:74:0) after 1m0s
[00:55:10.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:74:0)
[00:55:10.733] Timer tick, asking Buildbucket for the build status
[00:55:11.007] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:11.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:75:0) after 1m0s
[00:56:11.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:75:0)
[00:56:11.105] Timer tick, asking Buildbucket for the build status
[00:56:11.310] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:11.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:76:0) after 1m0s
[00:57:11.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:76:0)
[00:57:11.334] Timer tick, asking Buildbucket for the build status
[00:57:11.638] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:11.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:77:0) after 1m0s
[00:58:11.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:77:0)
[00:58:11.716] Timer tick, asking Buildbucket for the build status
[00:58:12.195] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:12.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:78:0) after 1m0s
[00:59:12.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:78:0)
[00:59:12.271] Timer tick, asking Buildbucket for the build status
[00:59:12.414] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:12.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:79:0) after 1m0s
[01:00:12.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:79:0)
[01:00:12.486] Timer tick, asking Buildbucket for the build status
[01:00:12.976] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:12.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:80:0) after 1m0s
[01:01:13.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:80:0)
[01:01:13.004] Timer tick, asking Buildbucket for the build status
[01:01:13.377] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:13.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:81:0) after 1m0s
[01:02:13.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:81:0)
[01:02:13.412] Timer tick, asking Buildbucket for the build status
[01:02:13.679] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:13.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:82:0) after 1m0s
[01:03:13.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:82:0)
[01:03:13.710] Timer tick, asking Buildbucket for the build status
[01:03:14.016] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:14.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:83:0) after 1m0s
[01:04:14.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:83:0)
[01:04:14.177] Timer tick, asking Buildbucket for the build status
[01:04:14.469] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:14.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:84:0) after 1m0s
[01:05:14.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:84:0)
[01:05:14.511] Timer tick, asking Buildbucket for the build status
[01:05:15.775] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:15.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:85:0) after 1m0s
[01:06:15.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:85:0)
[01:06:15.854] Timer tick, asking Buildbucket for the build status
[01:06:16.012] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:16.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:86:0) after 1m0s
[01:07:16.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:86:0)
[01:07:16.113] Timer tick, asking Buildbucket for the build status
[01:07:16.324] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:16.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:87:0) after 1m0s
[01:08:16.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:87:0)
[01:08:16.369] Timer tick, asking Buildbucket for the build status
[01:08:16.479] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:16.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:88:0) after 1m0s
[01:09:16.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:88:0)
[01:09:16.514] Timer tick, asking Buildbucket for the build status
[01:09:17.617] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:17.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:89:0) after 1m0s
[01:10:17.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:89:0)
[01:10:17.647] Timer tick, asking Buildbucket for the build status
[01:10:18.456] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:18.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:90:0) after 1m0s
[01:11:18.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:90:0)
[01:11:18.483] Timer tick, asking Buildbucket for the build status
[01:11:20.091] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:20.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:91:0) after 1m0s
[01:12:20.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:91:0)
[01:12:20.111] Timer tick, asking Buildbucket for the build status
[01:12:21.381] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:21.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:92:0) after 1m0s
[01:13:21.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:92:0)
[01:13:21.411] Timer tick, asking Buildbucket for the build status
[01:13:25.596] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:25.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:93:0) after 1m0s
[01:14:25.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:93:0)
[01:14:25.676] Timer tick, asking Buildbucket for the build status
[01:14:25.819] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:25.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:94:0) after 1m0s
[01:15:25.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:94:0)
[01:15:25.914] Timer tick, asking Buildbucket for the build status
[01:15:27.469] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:27.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:95:0) after 1m0s
[01:16:27.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:95:0)
[01:16:27.613] Timer tick, asking Buildbucket for the build status
[01:16:29.918] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:29.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:96:0) after 1m0s
[01:17:29.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:96:0)
[01:17:29.993] Timer tick, asking Buildbucket for the build status
[01:17:30.304] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:30.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:97:0) after 1m0s
[01:18:30.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:97:0)
[01:18:30.357] Timer tick, asking Buildbucket for the build status
[01:18:30.937] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:30.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:98:0) after 1m0s
[01:19:30.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:98:0)
[01:19:30.964] Timer tick, asking Buildbucket for the build status
[01:19:33.578] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:33.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:99:0) after 1m0s
[01:20:33.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:99:0)
[01:20:33.651] Timer tick, asking Buildbucket for the build status
[01:20:34.681] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:34.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:100:0) after 1m0s
[01:21:34.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:100:0)
[01:21:34.730] Timer tick, asking Buildbucket for the build status
[01:21:35.022] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:35.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:101:0) after 1m0s
[01:22:35.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:101:0)
[01:22:35.054] Timer tick, asking Buildbucket for the build status
[01:22:35.857] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:35.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:102:0) after 1m0s
[01:23:35.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:102:0)
[01:23:35.890] Timer tick, asking Buildbucket for the build status
[01:23:37.373] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:37.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:103:0) after 1m0s
[01:24:37.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:103:0)
[01:24:37.431] Timer tick, asking Buildbucket for the build status
[01:24:37.797] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:37.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:104:0) after 1m0s
[01:25:37.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:104:0)
[01:25:37.812] Timer tick, asking Buildbucket for the build status
[01:25:40.050] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:40.050] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:105:0) after 1m0s
[01:26:40.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:105:0)
[01:26:40.157] Timer tick, asking Buildbucket for the build status
[01:26:40.998] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:40.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:106:0) after 1m0s
[01:27:41.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:106:0)
[01:27:41.060] Timer tick, asking Buildbucket for the build status
[01:27:42.208] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:42.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:107:0) after 1m0s
[01:28:42.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:107:0)
[01:28:42.296] Timer tick, asking Buildbucket for the build status
[01:28:42.390] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:42.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:108:0) after 1m0s
[01:29:42.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:108:0)
[01:29:42.532] Timer tick, asking Buildbucket for the build status
[01:29:42.787] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:42.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:109:0) after 1m0s
[01:30:42.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:109:0)
[01:30:42.849] Timer tick, asking Buildbucket for the build status
[01:30:43.279] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:43.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:110:0) after 1m0s
[01:31:43.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:110:0)
[01:31:43.391] Timer tick, asking Buildbucket for the build status
[01:31:44.401] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:44.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:111:0) after 1m0s
[01:32:44.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:111:0)
[01:32:44.467] Timer tick, asking Buildbucket for the build status
[01:32:45.619] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:45.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:112:0) after 1m0s
[01:33:45.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:112:0)
[01:33:45.647] Timer tick, asking Buildbucket for the build status
[01:33:48.799] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:48.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:113:0) after 1m0s
[01:34:48.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:113:0)
[01:34:48.866] Timer tick, asking Buildbucket for the build status
[01:34:49.967] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:49.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:114:0) after 1m0s
[01:35:49.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:114:0)
[01:35:49.999] Timer tick, asking Buildbucket for the build status
[01:35:50.583] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:50.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:115:0) after 1m0s
[01:36:50.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:115:0)
[01:36:50.680] Timer tick, asking Buildbucket for the build status
[01:36:50.990] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:50.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:116:0) after 1m0s
[01:37:51.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:116:0)
[01:37:51.033] Timer tick, asking Buildbucket for the build status
[01:37:51.173] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:51.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:117:0) after 1m0s
[01:38:51.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:117:0)
[01:38:51.341] Timer tick, asking Buildbucket for the build status
[01:38:52.563] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:52.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:118:0) after 1m0s
[01:39:52.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:118:0)
[01:39:52.715] Timer tick, asking Buildbucket for the build status
[01:39:53.609] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:53.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:119:0) after 1m0s
[01:40:53.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:119:0)
[01:40:53.824] Timer tick, asking Buildbucket for the build status
[01:40:54.743] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:54.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:120:0) after 1m0s
[01:41:54.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:120:0)
[01:41:54.937] Timer tick, asking Buildbucket for the build status
[01:41:55.927] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:55.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:121:0) after 1m0s
[01:42:56.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:121:0)
[01:42:56.037] Timer tick, asking Buildbucket for the build status
[01:42:56.631] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:56.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:122:0) after 1m0s
[01:43:56.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:122:0)
[01:43:56.674] Timer tick, asking Buildbucket for the build status
[01:43:57.033] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:57.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:123:0) after 1m0s
[01:44:57.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:123:0)
[01:44:57.058] Timer tick, asking Buildbucket for the build status
[01:44:57.362] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:57.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:124:0) after 1m0s
[01:45:57.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:124:0)
[01:45:57.356] Timer tick, asking Buildbucket for the build status
[01:45:57.664] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:57.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:125:0) after 1m0s
[01:46:57.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:125:0)
[01:46:57.718] Timer tick, asking Buildbucket for the build status
[01:46:57.943] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:57.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:126:0) after 1m0s
[01:47:57.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:126:0)
[01:47:57.974] Timer tick, asking Buildbucket for the build status
[01:47:58.986] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:58.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:127:0) after 1m0s
[01:48:59.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:127:0)
[01:48:59.054] Timer tick, asking Buildbucket for the build status
[01:49:00.286] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:00.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:128:0) after 1m0s
[01:50:00.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:128:0)
[01:50:00.333] Timer tick, asking Buildbucket for the build status
[01:50:00.678] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:00.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:129:0) after 1m0s
[01:51:00.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:129:0)
[01:51:00.684] Timer tick, asking Buildbucket for the build status
[01:51:02.115] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:02.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:130:0) after 1m0s
[01:52:02.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:130:0)
[01:52:02.115] Timer tick, asking Buildbucket for the build status
[01:52:02.465] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:02.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:131:0) after 1m0s
[01:53:02.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:131:0)
[01:53:02.563] Timer tick, asking Buildbucket for the build status
[01:53:02.702] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:02.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:132:0) after 1m0s
[01:54:02.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:132:0)
[01:54:02.762] Timer tick, asking Buildbucket for the build status
[01:54:03.324] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:03.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:133:0) after 1m0s
[01:55:03.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:133:0)
[01:55:03.447] Timer tick, asking Buildbucket for the build status
[01:55:03.649] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:03.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:134:0) after 1m0s
[01:56:03.781] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:134:0)
[01:56:03.781] Timer tick, asking Buildbucket for the build status
[01:56:03.948] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:03.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:135:0) after 1m0s
[01:57:04.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:135:0)
[01:57:04.001] Timer tick, asking Buildbucket for the build status
[01:57:04.153] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:04.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:136:0) after 1m0s
[01:58:04.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:136:0)
[01:58:04.224] Timer tick, asking Buildbucket for the build status
[01:58:04.719] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:04.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:137:0) after 1m0s
[01:59:04.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:137:0)
[01:59:04.853] Timer tick, asking Buildbucket for the build status
[01:59:05.314] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:05.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:138:0) after 1m0s
[02:00:05.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:138:0)
[02:00:05.343] Timer tick, asking Buildbucket for the build status
[02:00:06.797] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:06.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:139:0) after 1m0s
[02:01:06.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:139:0)
[02:01:06.823] Timer tick, asking Buildbucket for the build status
[02:01:07.606] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:07.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:140:0) after 1m0s
[02:02:07.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:140:0)
[02:02:07.749] Timer tick, asking Buildbucket for the build status
[02:02:08.062] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:08.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:141:0) after 1m0s
[02:03:08.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:141:0)
[02:03:08.219] Timer tick, asking Buildbucket for the build status
[02:03:08.444] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:08.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:142:0) after 1m0s
[02:04:08.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:142:0)
[02:04:08.476] Timer tick, asking Buildbucket for the build status
[02:04:10.785] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:10.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:143:0) after 1m0s
[02:05:10.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:143:0)
[02:05:10.856] Timer tick, asking Buildbucket for the build status
[02:05:11.239] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:11.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:144:0) after 1m0s
[02:06:11.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:144:0)
[02:06:11.313] Timer tick, asking Buildbucket for the build status
[02:06:12.855] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:12.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:145:0) after 1m0s
[02:07:12.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:145:0)
[02:07:12.923] Timer tick, asking Buildbucket for the build status
[02:07:14.350] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:14.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:146:0) after 1m0s
[02:08:14.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:146:0)
[02:08:14.378] Timer tick, asking Buildbucket for the build status
[02:08:14.718] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:14.718] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:147:0) after 1m0s
[02:09:14.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:147:0)
[02:09:14.755] Timer tick, asking Buildbucket for the build status
[02:09:14.996] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:14.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:148:0) after 1m0s
[02:10:15.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:148:0)
[02:10:15.091] Timer tick, asking Buildbucket for the build status
[02:10:15.256] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:15.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:149:0) after 1m0s
[02:11:15.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:149:0)
[02:11:15.314] Timer tick, asking Buildbucket for the build status
[02:11:17.187] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:17.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:150:0) after 1m0s
[02:12:17.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:150:0)
[02:12:17.250] Timer tick, asking Buildbucket for the build status
[02:12:17.529] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:17.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:151:0) after 1m0s
[02:13:17.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:151:0)
[02:13:17.700] Timer tick, asking Buildbucket for the build status
[02:13:17.988] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:17.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:152:0) after 1m0s
[02:14:18.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:152:0)
[02:14:18.134] Timer tick, asking Buildbucket for the build status
[02:14:18.502] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:18.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:153:0) after 1m0s
[02:15:18.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:153:0)
[02:15:18.828] Timer tick, asking Buildbucket for the build status
[02:15:19.994] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:19.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:154:0) after 1m0s
[02:16:20.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:154:0)
[02:16:20.020] Timer tick, asking Buildbucket for the build status
[02:16:20.290] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:20.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:155:0) after 1m0s
[02:17:20.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:155:0)
[02:17:20.329] Timer tick, asking Buildbucket for the build status
[02:17:21.758] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:21.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:156:0) after 1m0s
[02:18:22.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:156:0)
[02:18:22.045] Timer tick, asking Buildbucket for the build status
[02:18:22.279] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:22.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:157:0) after 1m0s
[02:19:22.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:157:0)
[02:19:22.328] Timer tick, asking Buildbucket for the build status
[02:19:22.618] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:22.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:158:0) after 1m0s
[02:20:22.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:158:0)
[02:20:22.635] Timer tick, asking Buildbucket for the build status
[02:20:22.830] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:22.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:159:0) after 1m0s
[02:21:22.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:159:0)
[02:21:22.907] Timer tick, asking Buildbucket for the build status
[02:21:23.450] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:23.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:160:0) after 1m0s
[02:22:23.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:160:0)
[02:22:23.546] Timer tick, asking Buildbucket for the build status
[02:22:23.993] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:23.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:161:0) after 1m0s
[02:23:24.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:161:0)
[02:23:24.031] Timer tick, asking Buildbucket for the build status
[02:23:24.204] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:24.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:162:0) after 1m0s
[02:24:24.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:162:0)
[02:24:24.241] Timer tick, asking Buildbucket for the build status
[02:24:24.530] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:24.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:163:0) after 1m0s
[02:25:24.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:163:0)
[02:25:24.582] Timer tick, asking Buildbucket for the build status
[02:25:25.150] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:25.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:164:0) after 1m0s
[02:26:25.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:164:0)
[02:26:25.181] Timer tick, asking Buildbucket for the build status
[02:26:26.279] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:26.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:165:0) after 1m0s
[02:27:26.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:165:0)
[02:27:26.336] Timer tick, asking Buildbucket for the build status
[02:27:26.570] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:26.570] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:166:0) after 1m0s
[02:28:26.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:166:0)
[02:28:26.636] Timer tick, asking Buildbucket for the build status
[02:28:30.141] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:30.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:167:0) after 1m0s
[02:29:30.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:167:0)
[02:29:30.182] Timer tick, asking Buildbucket for the build status
[02:29:30.424] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:30.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:168:0) after 1m0s
[02:30:30.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:168:0)
[02:30:30.464] Timer tick, asking Buildbucket for the build status
[02:30:30.773] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:30.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:169:0) after 1m0s
[02:31:30.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:169:0)
[02:31:30.801] Timer tick, asking Buildbucket for the build status
[02:31:31.643] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:31.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:170:0) after 1m0s
[02:32:31.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:170:0)
[02:32:31.696] Timer tick, asking Buildbucket for the build status
[02:32:31.804] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:31.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:171:0) after 1m0s
[02:33:31.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:171:0)
[02:33:31.913] Timer tick, asking Buildbucket for the build status
[02:33:32.280] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:32.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:172:0) after 1m0s
[02:34:32.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:172:0)
[02:34:32.331] Timer tick, asking Buildbucket for the build status
[02:34:32.849] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:32.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:173:0) after 1m0s
[02:35:32.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:173:0)
[02:35:32.946] Timer tick, asking Buildbucket for the build status
[02:35:33.403] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:33.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:174:0) after 1m0s
[02:36:33.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:174:0)
[02:36:33.477] Timer tick, asking Buildbucket for the build status
[02:36:33.624] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:33.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:175:0) after 1m0s
[02:37:33.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:175:0)
[02:37:33.669] Timer tick, asking Buildbucket for the build status
[02:37:33.847] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:33.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:176:0) after 1m0s
[02:38:34.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:176:0)
[02:38:34.064] Timer tick, asking Buildbucket for the build status
[02:38:34.456] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:34.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:177:0) after 1m0s
[02:39:34.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:177:0)
[02:39:34.485] Timer tick, asking Buildbucket for the build status
[02:39:34.693] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:34.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:178:0) after 1m0s
[02:40:34.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:178:0)
[02:40:34.831] Timer tick, asking Buildbucket for the build status
[02:40:34.932] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:34.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:179:0) after 1m0s
[02:41:34.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:179:0)
[02:41:34.961] Timer tick, asking Buildbucket for the build status
[02:41:35.101] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:35.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:180:0) after 1m0s
[02:42:35.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:180:0)
[02:42:35.175] Timer tick, asking Buildbucket for the build status
[02:42:35.760] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:35.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:181:0) after 1m0s
[02:43:35.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:181:0)
[02:43:35.863] Timer tick, asking Buildbucket for the build status
[02:43:35.969] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:35.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:182:0) after 1m0s
[02:44:36.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:182:0)
[02:44:36.020] Timer tick, asking Buildbucket for the build status
[02:44:36.209] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:36.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:183:0) after 1m0s
[02:45:36.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:183:0)
[02:45:36.309] Timer tick, asking Buildbucket for the build status
[02:45:36.482] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:36.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:184:0) after 1m0s
[02:46:36.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:184:0)
[02:46:36.513] Timer tick, asking Buildbucket for the build status
[02:46:36.677] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:36.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:185:0) after 1m0s
[02:47:36.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:185:0)
[02:47:36.726] Timer tick, asking Buildbucket for the build status
[02:47:36.970] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:36.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:186:0) after 1m0s
[02:48:37.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:186:0)
[02:48:37.004] Timer tick, asking Buildbucket for the build status
[02:48:37.228] Build 8903022331796279568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:37.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:187:0) after 1m0s
[02:49:08.011] Received PubSub notification, asking Buildbucket for the build status
[02:49:08.136] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:37.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:187:0)
[02:49:37.230] Timer tick, asking Buildbucket for the build status
[02:49:37.614] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:37.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:189:0) after 1m0s
[02:50:37.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:189:0)
[02:50:37.686] Timer tick, asking Buildbucket for the build status
[02:50:37.886] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:37.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:190:0) after 1m0s
[02:51:37.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:190:0)
[02:51:37.968] Timer tick, asking Buildbucket for the build status
[02:51:38.116] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:38.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:191:0) after 1m0s
[02:52:38.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:191:0)
[02:52:38.281] Timer tick, asking Buildbucket for the build status
[02:52:38.780] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:38.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:192:0) after 1m0s
[02:53:38.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:192:0)
[02:53:38.948] Timer tick, asking Buildbucket for the build status
[02:53:39.152] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:39.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:193:0) after 1m0s
[02:54:39.180] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:193:0)
[02:54:39.180] Timer tick, asking Buildbucket for the build status
[02:54:39.345] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:39.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:194:0) after 1m0s
[02:55:39.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:194:0)
[02:55:39.414] Timer tick, asking Buildbucket for the build status
[02:55:39.714] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:39.714] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:195:0) after 1m0s
[02:56:39.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:195:0)
[02:56:39.755] Timer tick, asking Buildbucket for the build status
[02:56:40.119] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:40.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:196:0) after 1m0s
[02:57:40.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:196:0)
[02:57:40.204] Timer tick, asking Buildbucket for the build status
[02:57:40.327] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:40.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:197:0) after 1m0s
[02:58:40.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:197:0)
[02:58:40.384] Timer tick, asking Buildbucket for the build status
[02:58:40.760] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:40.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:198:0) after 1m0s
[02:59:40.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:198:0)
[02:59:40.851] Timer tick, asking Buildbucket for the build status
[02:59:40.992] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:40.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:199:0) after 1m0s
[03:00:41.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:199:0)
[03:00:41.056] Timer tick, asking Buildbucket for the build status
[03:00:41.230] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:41.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:200:0) after 1m0s
[03:01:41.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:200:0)
[03:01:41.358] Timer tick, asking Buildbucket for the build status
[03:01:41.479] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:41.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:201:0) after 1m0s
[03:02:41.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:201:0)
[03:02:41.538] Timer tick, asking Buildbucket for the build status
[03:02:41.896] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:41.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:202:0) after 1m0s
[03:03:41.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:202:0)
[03:03:41.976] Timer tick, asking Buildbucket for the build status
[03:03:42.107] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:42.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:203:0) after 1m0s
[03:04:42.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:203:0)
[03:04:42.135] Timer tick, asking Buildbucket for the build status
[03:04:42.321] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:42.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:204:0) after 1m0s
[03:05:42.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:204:0)
[03:05:42.419] Timer tick, asking Buildbucket for the build status
[03:05:42.517] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:42.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:205:0) after 1m0s
[03:06:42.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:205:0)
[03:06:42.575] Timer tick, asking Buildbucket for the build status
[03:06:43.129] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:43.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:206:0) after 1m0s
[03:07:43.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:206:0)
[03:07:43.166] Timer tick, asking Buildbucket for the build status
[03:07:43.366] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:43.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:207:0) after 1m0s
[03:08:43.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:207:0)
[03:08:43.407] Timer tick, asking Buildbucket for the build status
[03:08:43.586] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:43.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:208:0) after 1m0s
[03:09:43.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:208:0)
[03:09:43.600] Timer tick, asking Buildbucket for the build status
[03:09:43.794] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:43.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:209:0) after 1m0s
[03:10:43.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:209:0)
[03:10:43.813] Timer tick, asking Buildbucket for the build status
[03:10:44.114] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:44.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:210:0) after 1m0s
[03:11:44.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:210:0)
[03:11:44.198] Timer tick, asking Buildbucket for the build status
[03:11:44.323] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:44.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:211:0) after 1m0s
[03:12:44.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:211:0)
[03:12:44.380] Timer tick, asking Buildbucket for the build status
[03:12:44.499] Build 8903022331796279568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:44.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9068452393877593968:212:0) after 1m0s
[03:12:47.576] Received PubSub notification, asking Buildbucket for the build status
[03:12:47.707] Build 8903022331796279568: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[03:12:47.707] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1567825967037933",
    "created_by": "project:infra",
    "created_ts": "1567813285982396",
    "failure_reason": "BUILD_FAILURE",
    "id": "8903022331796279568",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"78.0.3904.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"0087416e-ba5b-467e-b3b9-1f4a84aaba62\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"78.0.3904.2\"}}",
    "project": "infra",
    "result": "FAILURE",
    "result_details_json": "{\"error\": {\"message\": \"Step('Download nodejs.') (retcode: 1)\"}, \"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\": \"78.0.3904.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"0087416e-ba5b-467e-b3b9-1f4a84aaba62\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-6n3s\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"78.0.3904.2\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-6n3s\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"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\": [\"4417-ad2503b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}, \"ui\": {\"info\": \"Step('Download nodejs.') (retcode: 1)\"}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1567824546663505",
    "status": "COMPLETED",
    "status_changed_ts": "1567824547494662",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9068452393877593968",
      "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/8903022331796279568/+/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:4721c5f1ec015f10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1567825967171798",
    "url": "https://ci.chromium.org/b/8903022331796279568",
    "utcnow_ts": "1567825967698832"
  }
}
[03:12:47.707] Invocation finished in 3h31m23.092472602s with status FAILED