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

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

{
  "version": "88.0.4291.2"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[02:35:36.253] New invocation is queued and will start shortly
[02:35:36.253] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[02:35:37.387] Starting the invocation (attempt 1)
[02:35:37.421] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:35:37.421] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:35:37.421] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9031930857097464208",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4291.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"9bb4d803-b624-45df-828e-438e9cf62f44\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4291.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:9031930857097464208",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[02:35:37.907] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1602642937573623",
    "id": "8866500795049560752",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4291.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9bb4d803-b624-45df-828e-438e9cf62f44\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4291.2\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1602642937788561",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9031930857097464208",
      "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/8866500795049560752/+/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": "1602642937788734",
    "url": "https://ci.chromium.org/b/8866500795049560752",
    "utcnow_ts": "1602642937901117"
  }
}
[02:35:37.908] Task URL: https://ci.chromium.org/b/8866500795049560752
[02:35:37.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:2:0) after 1m0s
[02:36:37.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:2:0)
[02:36:37.893] Timer tick, asking Buildbucket for the build status
[02:36:37.993] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:37.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:3:0) after 1m0s
[02:37:38.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:3:0)
[02:37:38.135] Timer tick, asking Buildbucket for the build status
[02:37:38.277] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:38.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:4:0) after 1m0s
[02:38:38.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:4:0)
[02:38:38.331] Timer tick, asking Buildbucket for the build status
[02:38:38.401] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:38.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:5:0) after 1m0s
[02:39:38.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:5:0)
[02:39:38.528] Timer tick, asking Buildbucket for the build status
[02:39:38.615] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:38.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:6:0) after 1m0s
[02:40:38.598] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:6:0)
[02:40:38.598] Timer tick, asking Buildbucket for the build status
[02:40:38.778] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:38.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:7:0) after 1m0s
[02:41:38.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:7:0)
[02:41:38.793] Timer tick, asking Buildbucket for the build status
[02:41:38.891] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:38.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:8:0) after 1m0s
[02:42:38.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:8:0)
[02:42:38.916] Timer tick, asking Buildbucket for the build status
[02:42:39.361] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:39.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:9:0) after 1m0s
[02:43:39.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:9:0)
[02:43:39.383] Timer tick, asking Buildbucket for the build status
[02:43:39.466] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:39.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:10:0) after 1m0s
[02:44:39.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:10:0)
[02:44:39.494] Timer tick, asking Buildbucket for the build status
[02:44:39.571] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:39.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:11:0) after 1m0s
[02:45:40.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:11:0)
[02:45:40.025] Timer tick, asking Buildbucket for the build status
[02:45:40.233] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:40.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:12:0) after 1m0s
[02:46:40.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:12:0)
[02:46:40.304] Timer tick, asking Buildbucket for the build status
[02:46:40.387] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:40.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:13:0) after 1m0s
[02:47:40.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:13:0)
[02:47:40.471] Timer tick, asking Buildbucket for the build status
[02:47:40.571] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:40.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:14:0) after 1m0s
[02:48:40.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:14:0)
[02:48:40.589] Timer tick, asking Buildbucket for the build status
[02:48:40.977] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:40.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:15:0) after 1m0s
[02:49:41.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:15:0)
[02:49:41.240] Timer tick, asking Buildbucket for the build status
[02:49:41.377] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:41.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:16:0) after 1m0s
[02:50:41.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:16:0)
[02:50:41.441] Timer tick, asking Buildbucket for the build status
[02:50:41.534] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:41.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:17:0) after 1m0s
[02:51:41.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:17:0)
[02:51:41.566] Timer tick, asking Buildbucket for the build status
[02:51:41.655] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:41.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:18:0) after 1m0s
[02:52:41.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:18:0)
[02:52:41.726] Timer tick, asking Buildbucket for the build status
[02:52:42.390] Build 8866500795049560752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:42.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:19:0) after 1m0s
[02:53:25.527] Received PubSub notification, asking Buildbucket for the build status
[02:53:25.609] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:42.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:19:0)
[02:53:42.430] Timer tick, asking Buildbucket for the build status
[02:53:42.708] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:42.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:21:0) after 1m0s
[02:54:42.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:21:0)
[02:54:42.715] Timer tick, asking Buildbucket for the build status
[02:54:42.839] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:42.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:22:0) after 1m0s
[02:55:43.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:22:0)
[02:55:43.341] Timer tick, asking Buildbucket for the build status
[02:55:43.450] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:43.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:23:0) after 1m0s
[02:56:43.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:23:0)
[02:56:43.467] Timer tick, asking Buildbucket for the build status
[02:56:43.608] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:43.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:24:0) after 1m0s
[02:57:43.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:24:0)
[02:57:43.692] Timer tick, asking Buildbucket for the build status
[02:57:43.763] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:43.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:25:0) after 1m0s
[02:58:43.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:25:0)
[02:58:43.852] Timer tick, asking Buildbucket for the build status
[02:58:43.920] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:43.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:26:0) after 1m0s
[02:59:43.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:26:0)
[02:59:43.987] Timer tick, asking Buildbucket for the build status
[02:59:44.057] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:44.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:27:0) after 1m0s
[03:00:44.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:27:0)
[03:00:44.414] Timer tick, asking Buildbucket for the build status
[03:00:44.537] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:44.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:28:0) after 1m0s
[03:01:44.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:28:0)
[03:01:44.719] Timer tick, asking Buildbucket for the build status
[03:01:44.791] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:44.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:29:0) after 1m0s
[03:02:44.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:29:0)
[03:02:44.937] Timer tick, asking Buildbucket for the build status
[03:02:45.105] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:45.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:30:0) after 1m0s
[03:03:45.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:30:0)
[03:03:45.118] Timer tick, asking Buildbucket for the build status
[03:03:45.202] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:45.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:31:0) after 1m0s
[03:04:45.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:31:0)
[03:04:45.232] Timer tick, asking Buildbucket for the build status
[03:04:45.312] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:45.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:32:0) after 1m0s
[03:05:45.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:32:0)
[03:05:45.334] Timer tick, asking Buildbucket for the build status
[03:05:45.462] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:45.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:33:0) after 1m0s
[03:06:45.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:33:0)
[03:06:45.544] Timer tick, asking Buildbucket for the build status
[03:06:45.609] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:45.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:34:0) after 1m0s
[03:07:45.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:34:0)
[03:07:45.661] Timer tick, asking Buildbucket for the build status
[03:07:45.724] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:45.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:35:0) after 1m0s
[03:08:45.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:35:0)
[03:08:45.719] Timer tick, asking Buildbucket for the build status
[03:08:45.788] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:45.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:36:0) after 1m0s
[03:09:45.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:36:0)
[03:09:45.845] Timer tick, asking Buildbucket for the build status
[03:09:46.097] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:46.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:37:0) after 1m0s
[03:10:46.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:37:0)
[03:10:46.131] Timer tick, asking Buildbucket for the build status
[03:10:46.254] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:46.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:38:0) after 1m0s
[03:11:46.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:38:0)
[03:11:46.308] Timer tick, asking Buildbucket for the build status
[03:11:46.356] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:46.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:39:0) after 1m0s
[03:12:46.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:39:0)
[03:12:46.476] Timer tick, asking Buildbucket for the build status
[03:12:46.565] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:46.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:40:0) after 1m0s
[03:13:46.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:40:0)
[03:13:46.686] Timer tick, asking Buildbucket for the build status
[03:13:46.761] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:46.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:41:0) after 1m0s
[03:14:46.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:41:0)
[03:14:46.822] Timer tick, asking Buildbucket for the build status
[03:14:47.107] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:47.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:42:0) after 1m0s
[03:15:47.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:42:0)
[03:15:47.203] Timer tick, asking Buildbucket for the build status
[03:15:47.352] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:47.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:43:0) after 1m0s
[03:16:47.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:43:0)
[03:16:47.473] Timer tick, asking Buildbucket for the build status
[03:16:47.921] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:47.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:44:0) after 1m0s
[03:17:47.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:44:0)
[03:17:47.943] Timer tick, asking Buildbucket for the build status
[03:17:48.178] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:48.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:45:0) after 1m0s
[03:18:48.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:45:0)
[03:18:48.291] Timer tick, asking Buildbucket for the build status
[03:18:48.691] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:48.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:46:0) after 1m0s
[03:19:48.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:46:0)
[03:19:48.732] Timer tick, asking Buildbucket for the build status
[03:19:48.814] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:48.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:47:0) after 1m0s
[03:20:48.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:47:0)
[03:20:48.918] Timer tick, asking Buildbucket for the build status
[03:20:49.190] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:49.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:48:0) after 1m0s
[03:21:49.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:48:0)
[03:21:49.213] Timer tick, asking Buildbucket for the build status
[03:21:49.266] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:49.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:49:0) after 1m0s
[03:22:49.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:49:0)
[03:22:49.376] Timer tick, asking Buildbucket for the build status
[03:22:49.509] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:49.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:50:0) after 1m0s
[03:23:49.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:50:0)
[03:23:49.567] Timer tick, asking Buildbucket for the build status
[03:23:49.663] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:49.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:51:0) after 1m0s
[03:24:49.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:51:0)
[03:24:49.687] Timer tick, asking Buildbucket for the build status
[03:24:49.749] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:49.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:52:0) after 1m0s
[03:25:49.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:52:0)
[03:25:49.757] Timer tick, asking Buildbucket for the build status
[03:25:49.872] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:49.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:53:0) after 1m0s
[03:26:49.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:53:0)
[03:26:49.914] Timer tick, asking Buildbucket for the build status
[03:26:49.975] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:49.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:54:0) after 1m0s
[03:27:50.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:54:0)
[03:27:50.002] Timer tick, asking Buildbucket for the build status
[03:27:50.056] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:50.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:55:0) after 1m0s
[03:28:50.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:55:0)
[03:28:50.074] Timer tick, asking Buildbucket for the build status
[03:28:50.173] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:50.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:56:0) after 1m0s
[03:29:50.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:56:0)
[03:29:50.337] Timer tick, asking Buildbucket for the build status
[03:29:50.415] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:50.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:57:0) after 1m0s
[03:30:50.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:57:0)
[03:30:50.539] Timer tick, asking Buildbucket for the build status
[03:30:50.884] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:50.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:58:0) after 1m0s
[03:31:50.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:58:0)
[03:31:50.930] Timer tick, asking Buildbucket for the build status
[03:31:51.005] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:51.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:59:0) after 1m0s
[03:32:51.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:59:0)
[03:32:51.128] Timer tick, asking Buildbucket for the build status
[03:32:51.190] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:51.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:60:0) after 1m0s
[03:33:51.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:60:0)
[03:33:51.232] Timer tick, asking Buildbucket for the build status
[03:33:51.304] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:51.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:61:0) after 1m0s
[03:34:51.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:61:0)
[03:34:51.316] Timer tick, asking Buildbucket for the build status
[03:34:51.384] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:51.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:62:0) after 1m0s
[03:35:51.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:62:0)
[03:35:51.395] Timer tick, asking Buildbucket for the build status
[03:35:51.882] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:51.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:63:0) after 1m0s
[03:36:51.944] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:63:0)
[03:36:51.944] Timer tick, asking Buildbucket for the build status
[03:36:52.023] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:52.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:64:0) after 1m0s
[03:37:52.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:64:0)
[03:37:52.059] Timer tick, asking Buildbucket for the build status
[03:37:52.122] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:52.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:65:0) after 1m0s
[03:38:52.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:65:0)
[03:38:52.149] Timer tick, asking Buildbucket for the build status
[03:38:52.316] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:52.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:66:0) after 1m0s
[03:39:52.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:66:0)
[03:39:52.346] Timer tick, asking Buildbucket for the build status
[03:39:52.425] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:52.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:67:0) after 1m0s
[03:40:52.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:67:0)
[03:40:52.448] Timer tick, asking Buildbucket for the build status
[03:40:52.551] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:52.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:68:0) after 1m0s
[03:41:52.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:68:0)
[03:41:52.559] Timer tick, asking Buildbucket for the build status
[03:41:52.719] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:52.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:69:0) after 1m0s
[03:42:52.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:69:0)
[03:42:52.770] Timer tick, asking Buildbucket for the build status
[03:42:52.837] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:52.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:70:0) after 1m0s
[03:43:52.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:70:0)
[03:43:52.913] Timer tick, asking Buildbucket for the build status
[03:43:52.981] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:52.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:71:0) after 1m0s
[03:44:53.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:71:0)
[03:44:53.055] Timer tick, asking Buildbucket for the build status
[03:44:53.141] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:53.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:72:0) after 1m0s
[03:45:53.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:72:0)
[03:45:53.166] Timer tick, asking Buildbucket for the build status
[03:45:53.310] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:53.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:73:0) after 1m0s
[03:46:53.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:73:0)
[03:46:53.336] Timer tick, asking Buildbucket for the build status
[03:46:53.454] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:53.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:74:0) after 1m0s
[03:47:53.504] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:74:0)
[03:47:53.504] Timer tick, asking Buildbucket for the build status
[03:47:53.631] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:53.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:75:0) after 1m0s
[03:48:53.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:75:0)
[03:48:53.710] Timer tick, asking Buildbucket for the build status
[03:48:54.029] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:54.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:76:0) after 1m0s
[03:49:54.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:76:0)
[03:49:54.062] Timer tick, asking Buildbucket for the build status
[03:49:54.353] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:54.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:77:0) after 1m0s
[03:50:54.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:77:0)
[03:50:54.421] Timer tick, asking Buildbucket for the build status
[03:50:54.534] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:54.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:78:0) after 1m0s
[03:51:54.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:78:0)
[03:51:54.545] Timer tick, asking Buildbucket for the build status
[03:51:54.898] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:54.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:79:0) after 1m0s
[03:52:54.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:79:0)
[03:52:54.949] Timer tick, asking Buildbucket for the build status
[03:52:54.996] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:54.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:80:0) after 1m0s
[03:53:55.050] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:80:0)
[03:53:55.051] Timer tick, asking Buildbucket for the build status
[03:53:55.154] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:55.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:81:0) after 1m0s
[03:54:55.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:81:0)
[03:54:55.315] Timer tick, asking Buildbucket for the build status
[03:54:55.387] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:55.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:82:0) after 1m0s
[03:55:55.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:82:0)
[03:55:55.480] Timer tick, asking Buildbucket for the build status
[03:55:55.658] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:55.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:83:0) after 1m0s
[03:56:55.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:83:0)
[03:56:55.780] Timer tick, asking Buildbucket for the build status
[03:56:55.852] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:55.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:84:0) after 1m0s
[03:57:55.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:84:0)
[03:57:55.920] Timer tick, asking Buildbucket for the build status
[03:57:55.992] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:55.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:85:0) after 1m0s
[03:58:56.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:85:0)
[03:58:56.056] Timer tick, asking Buildbucket for the build status
[03:58:56.214] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:56.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:86:0) after 1m0s
[03:59:56.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:86:0)
[03:59:56.270] Timer tick, asking Buildbucket for the build status
[03:59:56.333] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:56.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:87:0) after 1m0s
[04:00:56.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:87:0)
[04:00:56.363] Timer tick, asking Buildbucket for the build status
[04:00:56.484] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:56.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:88:0) after 1m0s
[04:01:56.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:88:0)
[04:01:56.549] Timer tick, asking Buildbucket for the build status
[04:01:56.725] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:56.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:89:0) after 1m0s
[04:02:56.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:89:0)
[04:02:56.794] Timer tick, asking Buildbucket for the build status
[04:02:56.849] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:56.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:90:0) after 1m0s
[04:03:56.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:90:0)
[04:03:56.922] Timer tick, asking Buildbucket for the build status
[04:03:56.999] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:56.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:91:0) after 1m0s
[04:04:57.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:91:0)
[04:04:57.004] Timer tick, asking Buildbucket for the build status
[04:04:57.091] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:57.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:92:0) after 1m0s
[04:05:57.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:92:0)
[04:05:57.104] Timer tick, asking Buildbucket for the build status
[04:05:57.214] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:57.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:93:0) after 1m0s
[04:06:57.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:93:0)
[04:06:57.227] Timer tick, asking Buildbucket for the build status
[04:06:57.332] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:57.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:94:0) after 1m0s
[04:07:57.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:94:0)
[04:07:57.398] Timer tick, asking Buildbucket for the build status
[04:07:57.512] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:57.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:95:0) after 1m0s
[04:08:57.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:95:0)
[04:08:57.567] Timer tick, asking Buildbucket for the build status
[04:08:57.782] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:57.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:96:0) after 1m0s
[04:09:57.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:96:0)
[04:09:57.804] Timer tick, asking Buildbucket for the build status
[04:09:57.862] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:57.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:97:0) after 1m0s
[04:10:57.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:97:0)
[04:10:57.887] Timer tick, asking Buildbucket for the build status
[04:10:58.300] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:58.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:98:0) after 1m0s
[04:11:58.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:98:0)
[04:11:58.330] Timer tick, asking Buildbucket for the build status
[04:11:58.411] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:58.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:99:0) after 1m0s
[04:12:58.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:99:0)
[04:12:58.471] Timer tick, asking Buildbucket for the build status
[04:12:58.813] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:58.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:100:0) after 1m0s
[04:13:58.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:100:0)
[04:13:58.838] Timer tick, asking Buildbucket for the build status
[04:13:58.929] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:58.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:101:0) after 1m0s
[04:14:59.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:101:0)
[04:14:59.098] Timer tick, asking Buildbucket for the build status
[04:14:59.161] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:59.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:102:0) after 1m0s
[04:15:59.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:102:0)
[04:15:59.254] Timer tick, asking Buildbucket for the build status
[04:15:59.385] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:59.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:103:0) after 1m0s
[04:16:59.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:103:0)
[04:16:59.396] Timer tick, asking Buildbucket for the build status
[04:16:59.465] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:59.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:104:0) after 1m0s
[04:17:59.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:104:0)
[04:17:59.537] Timer tick, asking Buildbucket for the build status
[04:17:59.814] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:59.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:105:0) after 1m0s
[04:18:59.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:105:0)
[04:18:59.816] Timer tick, asking Buildbucket for the build status
[04:18:59.920] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:59.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:106:0) after 1m0s
[04:19:59.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:106:0)
[04:19:59.984] Timer tick, asking Buildbucket for the build status
[04:20:00.194] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:00.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:107:0) after 1m0s
[04:21:01.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:107:0)
[04:21:01.683] Timer tick, asking Buildbucket for the build status
[04:21:02.037] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:02.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:108:0) after 1m0s
[04:22:02.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:108:0)
[04:22:02.817] Timer tick, asking Buildbucket for the build status
[04:22:02.888] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:02.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:109:0) after 1m0s
[04:23:02.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:109:0)
[04:23:02.912] Timer tick, asking Buildbucket for the build status
[04:23:02.977] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:02.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:110:0) after 1m0s
[04:24:03.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:110:0)
[04:24:03.005] Timer tick, asking Buildbucket for the build status
[04:24:03.083] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:03.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:111:0) after 1m0s
[04:25:03.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:111:0)
[04:25:03.175] Timer tick, asking Buildbucket for the build status
[04:25:03.352] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:03.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:112:0) after 1m0s
[04:26:03.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:112:0)
[04:26:03.336] Timer tick, asking Buildbucket for the build status
[04:26:03.516] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:03.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:113:0) after 1m0s
[04:27:03.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:113:0)
[04:27:03.583] Timer tick, asking Buildbucket for the build status
[04:27:03.811] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:03.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:114:0) after 1m0s
[04:28:03.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:114:0)
[04:28:03.900] Timer tick, asking Buildbucket for the build status
[04:28:04.026] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:04.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:115:0) after 1m0s
[04:29:04.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:115:0)
[04:29:04.047] Timer tick, asking Buildbucket for the build status
[04:29:04.247] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:04.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:116:0) after 1m0s
[04:30:04.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:116:0)
[04:30:04.233] Timer tick, asking Buildbucket for the build status
[04:30:04.309] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:04.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:117:0) after 1m0s
[04:31:04.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:117:0)
[04:31:04.341] Timer tick, asking Buildbucket for the build status
[04:31:04.448] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:04.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:118:0) after 1m0s
[04:32:04.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:118:0)
[04:32:04.468] Timer tick, asking Buildbucket for the build status
[04:32:04.527] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:04.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:119:0) after 1m0s
[04:33:04.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:119:0)
[04:33:04.580] Timer tick, asking Buildbucket for the build status
[04:33:04.651] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:04.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:120:0) after 1m0s
[04:34:04.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:120:0)
[04:34:04.676] Timer tick, asking Buildbucket for the build status
[04:34:04.740] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:04.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:121:0) after 1m0s
[04:35:04.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:121:0)
[04:35:04.775] Timer tick, asking Buildbucket for the build status
[04:35:04.884] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:04.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:122:0) after 1m0s
[04:36:04.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:122:0)
[04:36:04.894] Timer tick, asking Buildbucket for the build status
[04:36:05.157] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:05.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:123:0) after 1m0s
[04:37:05.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:123:0)
[04:37:05.194] Timer tick, asking Buildbucket for the build status
[04:37:05.531] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:05.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:124:0) after 1m0s
[04:38:05.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:124:0)
[04:38:05.560] Timer tick, asking Buildbucket for the build status
[04:38:05.732] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:05.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:125:0) after 1m0s
[04:39:05.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:125:0)
[04:39:05.763] Timer tick, asking Buildbucket for the build status
[04:39:05.916] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:05.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:126:0) after 1m0s
[04:40:05.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:126:0)
[04:40:05.974] Timer tick, asking Buildbucket for the build status
[04:40:06.115] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:06.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:127:0) after 1m0s
[04:41:06.136] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:127:0)
[04:41:06.136] Timer tick, asking Buildbucket for the build status
[04:41:06.290] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:06.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:128:0) after 1m0s
[04:42:06.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:128:0)
[04:42:06.298] Timer tick, asking Buildbucket for the build status
[04:42:06.425] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:06.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:129:0) after 1m0s
[04:43:06.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:129:0)
[04:43:06.560] Timer tick, asking Buildbucket for the build status
[04:43:06.640] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:06.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:130:0) after 1m0s
[04:44:06.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:130:0)
[04:44:06.728] Timer tick, asking Buildbucket for the build status
[04:44:06.805] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:06.805] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:131:0) after 1m0s
[04:45:06.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:131:0)
[04:45:06.943] Timer tick, asking Buildbucket for the build status
[04:45:07.002] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:07.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:132:0) after 1m0s
[04:46:07.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:132:0)
[04:46:07.162] Timer tick, asking Buildbucket for the build status
[04:46:07.699] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:07.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:133:0) after 1m0s
[04:47:07.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:133:0)
[04:47:07.790] Timer tick, asking Buildbucket for the build status
[04:47:07.904] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:07.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:134:0) after 1m0s
[04:48:08.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:134:0)
[04:48:08.014] Timer tick, asking Buildbucket for the build status
[04:48:08.168] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:08.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:135:0) after 1m0s
[04:49:09.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:135:0)
[04:49:09.313] Timer tick, asking Buildbucket for the build status
[04:49:09.384] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:09.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:136:0) after 1m0s
[04:50:09.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:136:0)
[04:50:09.836] Timer tick, asking Buildbucket for the build status
[04:50:09.898] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:09.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:137:0) after 1m0s
[04:51:10.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:137:0)
[04:51:10.055] Timer tick, asking Buildbucket for the build status
[04:51:11.189] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:11.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:138:0) after 1m0s
[04:52:11.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:138:0)
[04:52:11.342] Timer tick, asking Buildbucket for the build status
[04:52:11.419] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:11.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:139:0) after 1m0s
[04:53:11.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:139:0)
[04:53:11.455] Timer tick, asking Buildbucket for the build status
[04:53:11.521] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:11.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:140:0) after 1m0s
[04:54:11.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:140:0)
[04:54:11.611] Timer tick, asking Buildbucket for the build status
[04:54:11.718] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:11.718] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:141:0) after 1m0s
[04:55:11.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:141:0)
[04:55:11.741] Timer tick, asking Buildbucket for the build status
[04:55:11.808] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:11.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:142:0) after 1m0s
[04:56:11.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:142:0)
[04:56:11.872] Timer tick, asking Buildbucket for the build status
[04:56:12.051] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:12.051] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:143:0) after 1m0s
[04:57:12.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:143:0)
[04:57:12.144] Timer tick, asking Buildbucket for the build status
[04:57:12.492] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:12.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:144:0) after 1m0s
[04:58:12.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:144:0)
[04:58:12.550] Timer tick, asking Buildbucket for the build status
[04:58:12.611] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:12.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:145:0) after 1m0s
[04:59:13.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:145:0)
[04:59:13.188] Timer tick, asking Buildbucket for the build status
[04:59:13.242] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:13.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:146:0) after 1m0s
[05:00:13.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:146:0)
[05:00:13.494] Timer tick, asking Buildbucket for the build status
[05:00:13.715] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:13.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:147:0) after 1m0s
[05:01:14.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:147:0)
[05:01:14.972] Timer tick, asking Buildbucket for the build status
[05:01:15.184] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:15.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:148:0) after 1m0s
[05:02:15.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:148:0)
[05:02:15.337] Timer tick, asking Buildbucket for the build status
[05:02:15.524] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:15.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:149:0) after 1m0s
[05:03:15.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:149:0)
[05:03:15.604] Timer tick, asking Buildbucket for the build status
[05:03:15.773] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:15.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:150:0) after 1m0s
[05:04:15.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:150:0)
[05:04:15.994] Timer tick, asking Buildbucket for the build status
[05:04:16.094] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:16.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:151:0) after 1m0s
[05:05:16.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:151:0)
[05:05:16.277] Timer tick, asking Buildbucket for the build status
[05:05:16.394] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:16.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:152:0) after 1m0s
[05:06:16.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:152:0)
[05:06:16.570] Timer tick, asking Buildbucket for the build status
[05:06:16.669] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:16.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:153:0) after 1m0s
[05:07:16.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:153:0)
[05:07:16.816] Timer tick, asking Buildbucket for the build status
[05:07:16.871] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:16.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:154:0) after 1m0s
[05:08:17.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:154:0)
[05:08:17.152] Timer tick, asking Buildbucket for the build status
[05:08:17.374] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:17.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:155:0) after 1m0s
[05:09:17.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:155:0)
[05:09:17.398] Timer tick, asking Buildbucket for the build status
[05:09:17.475] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:17.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:156:0) after 1m0s
[05:10:20.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:156:0)
[05:10:20.682] Timer tick, asking Buildbucket for the build status
[05:10:20.903] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:20.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:157:0) after 1m0s
[05:11:21.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:157:0)
[05:11:21.741] Timer tick, asking Buildbucket for the build status
[05:11:21.835] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:21.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:158:0) after 1m0s
[05:12:21.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:158:0)
[05:12:21.896] Timer tick, asking Buildbucket for the build status
[05:12:21.998] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:21.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:159:0) after 1m0s
[05:13:22.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:159:0)
[05:13:22.011] Timer tick, asking Buildbucket for the build status
[05:13:22.212] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:22.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:160:0) after 1m0s
[05:14:22.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:160:0)
[05:14:22.261] Timer tick, asking Buildbucket for the build status
[05:14:22.347] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:22.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:161:0) after 1m0s
[05:15:22.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:161:0)
[05:15:22.539] Timer tick, asking Buildbucket for the build status
[05:15:22.610] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:22.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:162:0) after 1m0s
[05:16:22.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:162:0)
[05:16:22.906] Timer tick, asking Buildbucket for the build status
[05:16:23.201] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:23.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:163:0) after 1m0s
[05:17:23.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:163:0)
[05:17:23.234] Timer tick, asking Buildbucket for the build status
[05:17:23.308] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:23.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:164:0) after 1m0s
[05:18:23.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:164:0)
[05:18:23.351] Timer tick, asking Buildbucket for the build status
[05:18:23.442] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:23.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:165:0) after 1m0s
[05:19:23.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:165:0)
[05:19:23.556] Timer tick, asking Buildbucket for the build status
[05:19:23.629] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:23.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:166:0) after 1m0s
[05:20:23.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:166:0)
[05:20:23.782] Timer tick, asking Buildbucket for the build status
[05:20:23.882] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:23.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:167:0) after 1m0s
[05:21:23.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:167:0)
[05:21:23.907] Timer tick, asking Buildbucket for the build status
[05:21:24.017] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:24.017] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:168:0) after 1m0s
[05:22:24.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:168:0)
[05:22:24.125] Timer tick, asking Buildbucket for the build status
[05:22:24.208] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:24.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:169:0) after 1m0s
[05:23:24.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:169:0)
[05:23:24.278] Timer tick, asking Buildbucket for the build status
[05:23:24.349] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:24.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:170:0) after 1m0s
[05:24:24.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:170:0)
[05:24:24.424] Timer tick, asking Buildbucket for the build status
[05:24:24.483] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:24.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:171:0) after 1m0s
[05:25:24.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:171:0)
[05:25:24.545] Timer tick, asking Buildbucket for the build status
[05:25:24.647] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:24.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:172:0) after 1m0s
[05:26:24.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:172:0)
[05:26:24.806] Timer tick, asking Buildbucket for the build status
[05:26:25.313] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:25.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:173:0) after 1m0s
[05:27:25.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:173:0)
[05:27:25.527] Timer tick, asking Buildbucket for the build status
[05:27:25.585] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:25.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:174:0) after 1m0s
[05:28:25.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:174:0)
[05:28:25.734] Timer tick, asking Buildbucket for the build status
[05:28:25.852] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:25.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:175:0) after 1m0s
[05:29:25.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:175:0)
[05:29:25.984] Timer tick, asking Buildbucket for the build status
[05:29:26.092] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:26.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:176:0) after 1m0s
[05:30:26.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:176:0)
[05:30:26.291] Timer tick, asking Buildbucket for the build status
[05:30:26.365] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:26.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:177:0) after 1m0s
[05:31:26.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:177:0)
[05:31:26.567] Timer tick, asking Buildbucket for the build status
[05:31:26.692] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:26.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:178:0) after 1m0s
[05:32:26.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:178:0)
[05:32:26.830] Timer tick, asking Buildbucket for the build status
[05:32:26.894] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:26.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:179:0) after 1m0s
[05:33:26.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:179:0)
[05:33:26.989] Timer tick, asking Buildbucket for the build status
[05:33:27.096] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:27.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:180:0) after 1m0s
[05:34:27.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:180:0)
[05:34:27.161] Timer tick, asking Buildbucket for the build status
[05:34:27.408] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:27.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:181:0) after 1m0s
[05:35:27.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:181:0)
[05:35:27.439] Timer tick, asking Buildbucket for the build status
[05:35:27.601] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:27.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:182:0) after 1m0s
[05:36:27.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:182:0)
[05:36:27.627] Timer tick, asking Buildbucket for the build status
[05:36:27.986] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:27.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:183:0) after 1m0s
[05:37:28.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:183:0)
[05:37:28.079] Timer tick, asking Buildbucket for the build status
[05:37:28.310] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:28.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:184:0) after 1m0s
[05:38:28.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:184:0)
[05:38:28.373] Timer tick, asking Buildbucket for the build status
[05:38:28.442] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:28.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:185:0) after 1m0s
[05:39:28.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:185:0)
[05:39:28.473] Timer tick, asking Buildbucket for the build status
[05:39:28.694] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:28.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:186:0) after 1m0s
[05:40:28.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:186:0)
[05:40:28.729] Timer tick, asking Buildbucket for the build status
[05:40:29.041] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:29.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:187:0) after 1m0s
[05:41:29.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:187:0)
[05:41:29.076] Timer tick, asking Buildbucket for the build status
[05:41:29.898] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:29.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:188:0) after 1m0s
[05:42:29.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:188:0)
[05:42:29.873] Timer tick, asking Buildbucket for the build status
[05:42:29.936] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:29.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:189:0) after 1m0s
[05:43:29.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:189:0)
[05:43:29.955] Timer tick, asking Buildbucket for the build status
[05:43:30.028] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:30.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:190:0) after 1m0s
[05:44:30.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:190:0)
[05:44:30.078] Timer tick, asking Buildbucket for the build status
[05:44:30.156] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:30.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:191:0) after 1m0s
[05:45:30.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:191:0)
[05:45:30.187] Timer tick, asking Buildbucket for the build status
[05:45:30.265] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:30.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:192:0) after 1m0s
[05:46:30.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:192:0)
[05:46:30.304] Timer tick, asking Buildbucket for the build status
[05:46:30.416] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:30.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:193:0) after 1m0s
[05:47:30.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:193:0)
[05:47:30.450] Timer tick, asking Buildbucket for the build status
[05:47:31.379] Build 8866500795049560752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:31.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031930857097464208:194:0) after 1m0s
[05:48:14.446] Received PubSub notification, asking Buildbucket for the build status
[05:48:14.522] Build 8866500795049560752: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:48:14.522] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1602654493765992",
    "created_by": "project:infra",
    "created_ts": "1602642937573623",
    "id": "8866500795049560752",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4291.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9bb4d803-b624-45df-828e-438e9cf62f44\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4291.2\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_292036ca8cd0711903e829a3c5417e821d204af08fdef2e4b6d3affbee40eeb2_v2\", \"builder_4d1db109d30b9f0068cf0464722c703e05f788cd82e2d29876a9483818e7c333_v2\", \"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-dbqv\"], \"image\": [\"chrome-xenial-20101100-265b45aa9e2\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1602644004826225",
    "status": "COMPLETED",
    "status_changed_ts": "1602654494085837",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9031930857097464208",
      "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/8866500795049560752/+/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:4f3dc8110afa7010",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1602654494100223",
    "url": "https://ci.chromium.org/b/8866500795049560752",
    "utcnow_ts": "1602654494513198"
  }
}
[05:48:14.523] Invocation finished in 3h12m38.28597105s with status SUCCEEDED