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

• parent_buildername:publish_tarball
• user_agent:recipe

[10:55:38.888] New invocation is queued and will start shortly
[10:55:38.888] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[10:55:40.358] Starting the invocation (attempt 1)
[10:55:40.404] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:55:40.407] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:55:40.407] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9038059990777887424",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4226.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"f8b247af-3497-4917-b44d-7802d3bdab4d\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4226.0\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9038059990777887424",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[10:55:41.059] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1596797740549670",
    "id": "8872629928364184544",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4226.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f8b247af-3497-4917-b44d-7802d3bdab4d\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4226.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1596797740770334",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038059990777887424",
      "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/8872629928364184544/+/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": "1596797740770515",
    "url": "https://ci.chromium.org/b/8872629928364184544",
    "utcnow_ts": "1596797741044369"
  }
}
[10:55:41.059] Task URL: https://ci.chromium.org/b/8872629928364184544
[10:55:41.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:2:0) after 1m0s
[10:56:35.617] Received PubSub notification, asking Buildbucket for the build status
[10:56:35.730] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:41.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:2:0)
[10:56:41.068] Timer tick, asking Buildbucket for the build status
[10:56:41.164] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:41.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:4:0) after 1m0s
[10:57:41.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:4:0)
[10:57:41.197] Timer tick, asking Buildbucket for the build status
[10:57:41.476] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:41.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:5:0) after 1m0s
[10:58:41.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:5:0)
[10:58:41.574] Timer tick, asking Buildbucket for the build status
[10:58:41.682] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:41.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:6:0) after 1m0s
[10:59:41.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:6:0)
[10:59:41.743] Timer tick, asking Buildbucket for the build status
[10:59:41.922] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:41.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:7:0) after 1m0s
[11:00:42.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:7:0)
[11:00:42.075] Timer tick, asking Buildbucket for the build status
[11:00:42.196] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:42.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:8:0) after 1m0s
[11:01:42.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:8:0)
[11:01:42.274] Timer tick, asking Buildbucket for the build status
[11:01:42.486] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:42.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:9:0) after 1m0s
[11:02:42.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:9:0)
[11:02:42.523] Timer tick, asking Buildbucket for the build status
[11:02:42.784] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:42.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:10:0) after 1m0s
[11:03:42.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:10:0)
[11:03:42.779] Timer tick, asking Buildbucket for the build status
[11:03:42.854] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:42.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:11:0) after 1m0s
[11:04:42.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:11:0)
[11:04:42.941] Timer tick, asking Buildbucket for the build status
[11:04:43.049] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:43.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:12:0) after 1m0s
[11:05:43.072] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:12:0)
[11:05:43.072] Timer tick, asking Buildbucket for the build status
[11:05:43.383] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:43.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:13:0) after 1m0s
[11:06:43.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:13:0)
[11:06:43.488] Timer tick, asking Buildbucket for the build status
[11:06:43.586] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:43.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:14:0) after 1m0s
[11:07:43.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:14:0)
[11:07:43.609] Timer tick, asking Buildbucket for the build status
[11:07:43.721] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:43.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:15:0) after 1m0s
[11:08:43.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:15:0)
[11:08:43.816] Timer tick, asking Buildbucket for the build status
[11:08:43.920] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:43.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:16:0) after 1m0s
[11:09:43.980] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:16:0)
[11:09:43.980] Timer tick, asking Buildbucket for the build status
[11:09:44.256] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:44.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:17:0) after 1m0s
[11:10:44.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:17:0)
[11:10:44.275] Timer tick, asking Buildbucket for the build status
[11:10:44.348] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:44.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:18:0) after 1m0s
[11:11:44.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:18:0)
[11:11:44.497] Timer tick, asking Buildbucket for the build status
[11:11:44.685] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:44.685] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:19:0) after 1m0s
[11:12:44.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:19:0)
[11:12:44.812] Timer tick, asking Buildbucket for the build status
[11:12:44.891] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:44.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:20:0) after 1m0s
[11:13:45.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:20:0)
[11:13:45.085] Timer tick, asking Buildbucket for the build status
[11:13:45.267] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:45.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:21:0) after 1m0s
[11:14:45.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:21:0)
[11:14:45.317] Timer tick, asking Buildbucket for the build status
[11:14:45.588] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:45.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:22:0) after 1m0s
[11:15:45.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:22:0)
[11:15:45.671] Timer tick, asking Buildbucket for the build status
[11:15:45.932] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:45.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:23:0) after 1m0s
[11:16:45.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:23:0)
[11:16:45.914] Timer tick, asking Buildbucket for the build status
[11:16:46.077] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:46.077] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:24:0) after 1m0s
[11:17:46.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:24:0)
[11:17:46.103] Timer tick, asking Buildbucket for the build status
[11:17:46.187] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:46.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:25:0) after 1m0s
[11:18:46.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:25:0)
[11:18:46.215] Timer tick, asking Buildbucket for the build status
[11:18:46.355] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:46.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:26:0) after 1m0s
[11:19:46.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:26:0)
[11:19:46.421] Timer tick, asking Buildbucket for the build status
[11:19:46.733] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:46.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:27:0) after 1m0s
[11:20:46.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:27:0)
[11:20:46.757] Timer tick, asking Buildbucket for the build status
[11:20:47.280] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:47.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:28:0) after 1m0s
[11:21:47.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:28:0)
[11:21:47.411] Timer tick, asking Buildbucket for the build status
[11:21:47.485] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:47.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:29:0) after 1m0s
[11:22:47.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:29:0)
[11:22:47.525] Timer tick, asking Buildbucket for the build status
[11:22:47.618] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:47.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:30:0) after 1m0s
[11:23:47.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:30:0)
[11:23:47.672] Timer tick, asking Buildbucket for the build status
[11:23:47.937] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:47.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:31:0) after 1m0s
[11:24:48.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:31:0)
[11:24:48.079] Timer tick, asking Buildbucket for the build status
[11:24:48.172] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:48.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:32:0) after 1m0s
[11:25:48.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:32:0)
[11:25:48.288] Timer tick, asking Buildbucket for the build status
[11:25:48.411] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:48.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:33:0) after 1m0s
[11:26:48.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:33:0)
[11:26:48.436] Timer tick, asking Buildbucket for the build status
[11:26:48.557] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:48.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:34:0) after 1m0s
[11:27:48.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:34:0)
[11:27:48.688] Timer tick, asking Buildbucket for the build status
[11:27:48.771] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:48.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:35:0) after 1m0s
[11:28:48.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:35:0)
[11:28:48.896] Timer tick, asking Buildbucket for the build status
[11:28:49.128] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:49.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:36:0) after 1m0s
[11:29:49.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:36:0)
[11:29:49.302] Timer tick, asking Buildbucket for the build status
[11:29:49.424] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:49.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:37:0) after 1m0s
[11:30:49.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:37:0)
[11:30:49.424] Timer tick, asking Buildbucket for the build status
[11:30:49.658] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:49.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:38:0) after 1m0s
[11:31:49.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:38:0)
[11:31:49.775] Timer tick, asking Buildbucket for the build status
[11:31:49.902] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:49.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:39:0) after 1m0s
[11:32:49.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:39:0)
[11:32:49.931] Timer tick, asking Buildbucket for the build status
[11:32:50.334] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:50.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:40:0) after 1m0s
[11:33:50.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:40:0)
[11:33:50.417] Timer tick, asking Buildbucket for the build status
[11:33:50.532] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:50.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:41:0) after 1m0s
[11:34:51.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:41:0)
[11:34:51.169] Timer tick, asking Buildbucket for the build status
[11:34:51.350] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:51.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:42:0) after 1m0s
[11:35:51.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:42:0)
[11:35:51.496] Timer tick, asking Buildbucket for the build status
[11:35:51.813] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:51.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:43:0) after 1m0s
[11:36:51.990] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:43:0)
[11:36:51.990] Timer tick, asking Buildbucket for the build status
[11:36:52.067] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:52.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:44:0) after 1m0s
[11:37:52.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:44:0)
[11:37:52.222] Timer tick, asking Buildbucket for the build status
[11:37:52.327] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:52.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:45:0) after 1m0s
[11:38:52.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:45:0)
[11:38:52.566] Timer tick, asking Buildbucket for the build status
[11:38:52.640] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:52.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:46:0) after 1m0s
[11:39:52.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:46:0)
[11:39:52.915] Timer tick, asking Buildbucket for the build status
[11:39:52.986] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:52.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:47:0) after 1m0s
[11:40:53.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:47:0)
[11:40:53.158] Timer tick, asking Buildbucket for the build status
[11:40:53.326] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:53.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:48:0) after 1m0s
[11:41:53.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:48:0)
[11:41:53.543] Timer tick, asking Buildbucket for the build status
[11:41:53.669] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:53.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:49:0) after 1m0s
[11:42:53.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:49:0)
[11:42:53.691] Timer tick, asking Buildbucket for the build status
[11:42:53.803] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:53.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:50:0) after 1m0s
[11:43:53.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:50:0)
[11:43:53.832] Timer tick, asking Buildbucket for the build status
[11:43:53.911] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:53.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:51:0) after 1m0s
[11:44:53.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:51:0)
[11:44:53.957] Timer tick, asking Buildbucket for the build status
[11:44:54.032] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:54.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:52:0) after 1m0s
[11:45:54.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:52:0)
[11:45:54.092] Timer tick, asking Buildbucket for the build status
[11:45:54.289] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:54.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:53:0) after 1m0s
[11:46:54.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:53:0)
[11:46:54.349] Timer tick, asking Buildbucket for the build status
[11:46:54.513] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:54.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:54:0) after 1m0s
[11:47:54.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:54:0)
[11:47:54.576] Timer tick, asking Buildbucket for the build status
[11:47:54.785] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:54.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:55:0) after 1m0s
[11:48:54.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:55:0)
[11:48:54.815] Timer tick, asking Buildbucket for the build status
[11:48:54.949] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:54.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:56:0) after 1m0s
[11:49:55.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:56:0)
[11:49:55.006] Timer tick, asking Buildbucket for the build status
[11:49:55.240] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:55.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:57:0) after 1m0s
[11:50:55.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:57:0)
[11:50:55.369] Timer tick, asking Buildbucket for the build status
[11:50:55.502] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:55.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:58:0) after 1m0s
[11:51:55.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:58:0)
[11:51:55.594] Timer tick, asking Buildbucket for the build status
[11:51:55.895] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:55.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:59:0) after 1m0s
[11:52:55.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:59:0)
[11:52:55.962] Timer tick, asking Buildbucket for the build status
[11:52:56.139] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:56.140] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:60:0) after 1m0s
[11:53:56.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:60:0)
[11:53:56.433] Timer tick, asking Buildbucket for the build status
[11:53:56.542] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:56.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:61:0) after 1m0s
[11:54:56.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:61:0)
[11:54:56.762] Timer tick, asking Buildbucket for the build status
[11:54:56.849] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:56.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:62:0) after 1m0s
[11:55:56.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:62:0)
[11:55:56.862] Timer tick, asking Buildbucket for the build status
[11:55:57.634] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:57.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:63:0) after 1m0s
[11:56:57.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:63:0)
[11:56:57.780] Timer tick, asking Buildbucket for the build status
[11:56:57.884] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:57.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:64:0) after 1m0s
[11:57:57.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:64:0)
[11:57:57.948] Timer tick, asking Buildbucket for the build status
[11:57:58.036] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:58.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:65:0) after 1m0s
[11:58:58.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:65:0)
[11:58:58.084] Timer tick, asking Buildbucket for the build status
[11:58:58.239] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:58.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:66:0) after 1m0s
[11:59:58.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:66:0)
[11:59:58.327] Timer tick, asking Buildbucket for the build status
[11:59:58.417] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:58.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:67:0) after 1m0s
[12:00:58.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:67:0)
[12:00:58.640] Timer tick, asking Buildbucket for the build status
[12:00:58.826] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:58.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:68:0) after 1m0s
[12:01:59.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:68:0)
[12:01:59.203] Timer tick, asking Buildbucket for the build status
[12:01:59.288] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:59.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:69:0) after 1m0s
[12:02:59.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:69:0)
[12:02:59.374] Timer tick, asking Buildbucket for the build status
[12:02:59.467] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:59.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:70:0) after 1m0s
[12:03:59.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:70:0)
[12:03:59.607] Timer tick, asking Buildbucket for the build status
[12:03:59.976] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:59.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:71:0) after 1m0s
[12:05:00.121] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:71:0)
[12:05:00.121] Timer tick, asking Buildbucket for the build status
[12:05:00.193] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:00.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:72:0) after 1m0s
[12:06:00.222] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:72:0)
[12:06:00.222] Timer tick, asking Buildbucket for the build status
[12:06:00.368] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:00.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:73:0) after 1m0s
[12:07:00.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:73:0)
[12:07:00.459] Timer tick, asking Buildbucket for the build status
[12:07:00.582] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:00.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:74:0) after 1m0s
[12:08:01.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:74:0)
[12:08:01.178] Timer tick, asking Buildbucket for the build status
[12:08:01.279] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:01.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:75:0) after 1m0s
[12:09:01.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:75:0)
[12:09:01.773] Timer tick, asking Buildbucket for the build status
[12:09:01.878] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:01.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:76:0) after 1m0s
[12:10:02.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:76:0)
[12:10:02.219] Timer tick, asking Buildbucket for the build status
[12:10:02.448] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:02.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:77:0) after 1m0s
[12:11:02.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:77:0)
[12:11:02.547] Timer tick, asking Buildbucket for the build status
[12:11:02.954] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:02.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:78:0) after 1m0s
[12:12:03.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:78:0)
[12:12:03.141] Timer tick, asking Buildbucket for the build status
[12:12:03.215] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:03.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:79:0) after 1m0s
[12:13:03.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:79:0)
[12:13:03.377] Timer tick, asking Buildbucket for the build status
[12:13:03.518] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:03.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:80:0) after 1m0s
[12:14:03.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:80:0)
[12:14:03.704] Timer tick, asking Buildbucket for the build status
[12:14:04.033] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:04.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:81:0) after 1m0s
[12:15:04.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:81:0)
[12:15:04.089] Timer tick, asking Buildbucket for the build status
[12:15:04.356] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:04.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:82:0) after 1m0s
[12:16:04.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:82:0)
[12:16:04.463] Timer tick, asking Buildbucket for the build status
[12:16:04.609] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:04.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:83:0) after 1m0s
[12:17:04.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:83:0)
[12:17:04.680] Timer tick, asking Buildbucket for the build status
[12:17:04.908] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:04.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:84:0) after 1m0s
[12:18:05.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:84:0)
[12:18:05.046] Timer tick, asking Buildbucket for the build status
[12:18:05.173] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:05.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:85:0) after 1m0s
[12:19:05.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:85:0)
[12:19:05.261] Timer tick, asking Buildbucket for the build status
[12:19:05.344] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:05.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:86:0) after 1m0s
[12:20:05.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:86:0)
[12:20:05.461] Timer tick, asking Buildbucket for the build status
[12:20:05.576] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:05.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:87:0) after 1m0s
[12:21:05.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:87:0)
[12:21:05.675] Timer tick, asking Buildbucket for the build status
[12:21:05.955] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:05.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:88:0) after 1m0s
[12:22:06.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:88:0)
[12:22:06.023] Timer tick, asking Buildbucket for the build status
[12:22:06.133] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:06.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:89:0) after 1m0s
[12:23:06.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:89:0)
[12:23:06.189] Timer tick, asking Buildbucket for the build status
[12:23:06.574] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:06.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:90:0) after 1m0s
[12:24:06.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:90:0)
[12:24:06.622] Timer tick, asking Buildbucket for the build status
[12:24:06.717] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:06.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:91:0) after 1m0s
[12:25:06.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:91:0)
[12:25:06.748] Timer tick, asking Buildbucket for the build status
[12:25:06.886] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:06.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:92:0) after 1m0s
[12:26:06.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:92:0)
[12:26:06.921] Timer tick, asking Buildbucket for the build status
[12:26:07.114] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:07.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:93:0) after 1m0s
[12:27:07.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:93:0)
[12:27:07.151] Timer tick, asking Buildbucket for the build status
[12:27:07.296] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:07.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:94:0) after 1m0s
[12:28:07.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:94:0)
[12:28:07.358] Timer tick, asking Buildbucket for the build status
[12:28:07.563] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:07.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:95:0) after 1m0s
[12:29:07.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:95:0)
[12:29:07.590] Timer tick, asking Buildbucket for the build status
[12:29:07.751] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:07.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:96:0) after 1m0s
[12:30:07.792] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:96:0)
[12:30:07.792] Timer tick, asking Buildbucket for the build status
[12:30:07.917] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:07.917] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:97:0) after 1m0s
[12:31:08.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:97:0)
[12:31:08.775] Timer tick, asking Buildbucket for the build status
[12:31:08.996] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:08.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:98:0) after 1m0s
[12:32:09.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:98:0)
[12:32:09.774] Timer tick, asking Buildbucket for the build status
[12:32:09.926] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:09.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:99:0) after 1m0s
[12:33:10.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:99:0)
[12:33:10.032] Timer tick, asking Buildbucket for the build status
[12:33:10.164] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:10.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:100:0) after 1m0s
[12:34:10.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:100:0)
[12:34:10.284] Timer tick, asking Buildbucket for the build status
[12:34:10.503] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:10.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:101:0) after 1m0s
[12:35:10.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:101:0)
[12:35:10.608] Timer tick, asking Buildbucket for the build status
[12:35:10.681] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:10.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:102:0) after 1m0s
[12:36:10.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:102:0)
[12:36:10.775] Timer tick, asking Buildbucket for the build status
[12:36:11.554] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:11.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:103:0) after 1m0s
[12:37:11.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:103:0)
[12:37:11.556] Timer tick, asking Buildbucket for the build status
[12:37:11.624] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:11.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:104:0) after 1m0s
[12:38:11.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:104:0)
[12:38:11.698] Timer tick, asking Buildbucket for the build status
[12:38:11.941] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:11.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:105:0) after 1m0s
[12:39:11.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:105:0)
[12:39:11.983] Timer tick, asking Buildbucket for the build status
[12:39:12.062] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:12.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:106:0) after 1m0s
[12:40:12.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:106:0)
[12:40:12.092] Timer tick, asking Buildbucket for the build status
[12:40:12.168] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:12.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:107:0) after 1m0s
[12:41:12.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:107:0)
[12:41:12.203] Timer tick, asking Buildbucket for the build status
[12:41:12.545] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:12.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:108:0) after 1m0s
[12:42:12.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:108:0)
[12:42:12.585] Timer tick, asking Buildbucket for the build status
[12:42:12.866] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:12.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:109:0) after 1m0s
[12:43:12.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:109:0)
[12:43:12.938] Timer tick, asking Buildbucket for the build status
[12:43:13.033] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:13.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:110:0) after 1m0s
[12:44:13.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:110:0)
[12:44:13.063] Timer tick, asking Buildbucket for the build status
[12:44:13.225] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:13.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:111:0) after 1m0s
[12:45:13.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:111:0)
[12:45:13.227] Timer tick, asking Buildbucket for the build status
[12:45:13.343] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:13.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:112:0) after 1m0s
[12:46:13.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:112:0)
[12:46:13.381] Timer tick, asking Buildbucket for the build status
[12:46:13.550] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:13.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:113:0) after 1m0s
[12:47:13.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:113:0)
[12:47:13.615] Timer tick, asking Buildbucket for the build status
[12:47:13.682] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:13.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:114:0) after 1m0s
[12:48:13.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:114:0)
[12:48:13.732] Timer tick, asking Buildbucket for the build status
[12:48:13.819] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:13.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:115:0) after 1m0s
[12:49:13.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:115:0)
[12:49:13.873] Timer tick, asking Buildbucket for the build status
[12:49:14.043] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:14.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:116:0) after 1m0s
[12:50:14.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:116:0)
[12:50:14.129] Timer tick, asking Buildbucket for the build status
[12:50:14.238] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:14.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:117:0) after 1m0s
[12:51:14.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:117:0)
[12:51:14.308] Timer tick, asking Buildbucket for the build status
[12:51:14.527] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:14.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:118:0) after 1m0s
[12:52:14.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:118:0)
[12:52:14.547] Timer tick, asking Buildbucket for the build status
[12:52:14.660] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:14.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:119:0) after 1m0s
[12:53:14.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:119:0)
[12:53:14.762] Timer tick, asking Buildbucket for the build status
[12:53:14.999] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:14.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:120:0) after 1m0s
[12:54:15.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:120:0)
[12:54:15.001] Timer tick, asking Buildbucket for the build status
[12:54:15.360] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:15.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:121:0) after 1m0s
[12:55:15.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:121:0)
[12:55:15.842] Timer tick, asking Buildbucket for the build status
[12:55:15.992] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:15.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:122:0) after 1m0s
[12:56:16.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:122:0)
[12:56:16.182] Timer tick, asking Buildbucket for the build status
[12:56:16.340] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:16.340] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:123:0) after 1m0s
[12:57:16.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:123:0)
[12:57:16.466] Timer tick, asking Buildbucket for the build status
[12:57:16.553] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:16.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:124:0) after 1m0s
[12:58:16.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:124:0)
[12:58:16.624] Timer tick, asking Buildbucket for the build status
[12:58:16.803] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:16.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:125:0) after 1m0s
[12:59:16.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:125:0)
[12:59:16.985] Timer tick, asking Buildbucket for the build status
[12:59:17.061] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:17.061] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:126:0) after 1m0s
[13:00:17.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:126:0)
[13:00:17.261] Timer tick, asking Buildbucket for the build status
[13:00:17.384] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:17.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:127:0) after 1m0s
[13:01:17.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:127:0)
[13:01:17.700] Timer tick, asking Buildbucket for the build status
[13:01:18.493] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:18.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:128:0) after 1m0s
[13:02:18.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:128:0)
[13:02:18.614] Timer tick, asking Buildbucket for the build status
[13:02:18.871] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:18.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:129:0) after 1m0s
[13:03:18.952] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:129:0)
[13:03:18.952] Timer tick, asking Buildbucket for the build status
[13:03:19.349] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:19.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:130:0) after 1m0s
[13:04:19.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:130:0)
[13:04:19.430] Timer tick, asking Buildbucket for the build status
[13:04:19.869] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:19.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:131:0) after 1m0s
[13:05:19.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:131:0)
[13:05:19.964] Timer tick, asking Buildbucket for the build status
[13:05:20.154] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:20.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:132:0) after 1m0s
[13:06:20.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:132:0)
[13:06:20.196] Timer tick, asking Buildbucket for the build status
[13:06:20.327] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:20.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:133:0) after 1m0s
[13:07:20.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:133:0)
[13:07:20.354] Timer tick, asking Buildbucket for the build status
[13:07:20.457] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:20.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:134:0) after 1m0s
[13:08:20.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:134:0)
[13:08:20.484] Timer tick, asking Buildbucket for the build status
[13:08:20.673] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:20.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:135:0) after 1m0s
[13:09:20.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:135:0)
[13:09:20.724] Timer tick, asking Buildbucket for the build status
[13:09:20.813] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:20.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:136:0) after 1m0s
[13:10:20.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:136:0)
[13:10:20.879] Timer tick, asking Buildbucket for the build status
[13:10:21.006] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:21.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:137:0) after 1m0s
[13:11:21.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:137:0)
[13:11:21.134] Timer tick, asking Buildbucket for the build status
[13:11:21.456] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:21.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:138:0) after 1m0s
[13:12:21.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:138:0)
[13:12:21.592] Timer tick, asking Buildbucket for the build status
[13:12:21.954] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:21.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:139:0) after 1m0s
[13:13:22.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:139:0)
[13:13:22.084] Timer tick, asking Buildbucket for the build status
[13:13:22.173] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:22.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:140:0) after 1m0s
[13:14:22.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:140:0)
[13:14:22.212] Timer tick, asking Buildbucket for the build status
[13:14:22.285] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:22.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:141:0) after 1m0s
[13:15:22.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:141:0)
[13:15:22.402] Timer tick, asking Buildbucket for the build status
[13:15:22.488] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:22.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:142:0) after 1m0s
[13:16:22.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:142:0)
[13:16:22.517] Timer tick, asking Buildbucket for the build status
[13:16:22.654] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:22.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:143:0) after 1m0s
[13:17:22.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:143:0)
[13:17:22.718] Timer tick, asking Buildbucket for the build status
[13:17:22.849] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:22.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:144:0) after 1m0s
[13:18:22.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:144:0)
[13:18:22.949] Timer tick, asking Buildbucket for the build status
[13:18:23.041] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:23.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:145:0) after 1m0s
[13:19:23.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:145:0)
[13:19:23.233] Timer tick, asking Buildbucket for the build status
[13:19:23.445] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:23.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:146:0) after 1m0s
[13:20:23.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:146:0)
[13:20:23.446] Timer tick, asking Buildbucket for the build status
[13:20:23.794] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:23.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:147:0) after 1m0s
[13:21:23.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:147:0)
[13:21:23.898] Timer tick, asking Buildbucket for the build status
[13:21:24.064] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:24.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:148:0) after 1m0s
[13:22:24.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:148:0)
[13:22:24.150] Timer tick, asking Buildbucket for the build status
[13:22:24.232] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:24.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:149:0) after 1m0s
[13:23:24.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:149:0)
[13:23:24.345] Timer tick, asking Buildbucket for the build status
[13:23:24.461] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:24.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:150:0) after 1m0s
[13:24:24.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:150:0)
[13:24:24.697] Timer tick, asking Buildbucket for the build status
[13:24:24.949] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:24.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:151:0) after 1m0s
[13:25:25.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:151:0)
[13:25:25.026] Timer tick, asking Buildbucket for the build status
[13:25:25.233] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:25.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:152:0) after 1m0s
[13:26:25.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:152:0)
[13:26:25.289] Timer tick, asking Buildbucket for the build status
[13:26:25.578] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:25.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:153:0) after 1m0s
[13:27:25.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:153:0)
[13:27:25.602] Timer tick, asking Buildbucket for the build status
[13:27:25.721] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:25.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:154:0) after 1m0s
[13:28:25.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:154:0)
[13:28:25.750] Timer tick, asking Buildbucket for the build status
[13:28:25.835] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:25.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:155:0) after 1m0s
[13:29:25.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:155:0)
[13:29:25.945] Timer tick, asking Buildbucket for the build status
[13:29:26.234] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:26.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:156:0) after 1m0s
[13:30:26.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:156:0)
[13:30:26.282] Timer tick, asking Buildbucket for the build status
[13:30:26.336] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:26.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:157:0) after 1m0s
[13:31:26.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:157:0)
[13:31:26.428] Timer tick, asking Buildbucket for the build status
[13:31:26.721] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:26.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:158:0) after 1m0s
[13:32:26.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:158:0)
[13:32:26.777] Timer tick, asking Buildbucket for the build status
[13:32:26.867] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:26.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:159:0) after 1m0s
[13:33:27.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:159:0)
[13:33:27.093] Timer tick, asking Buildbucket for the build status
[13:33:27.183] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:27.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:160:0) after 1m0s
[13:34:27.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:160:0)
[13:34:27.218] Timer tick, asking Buildbucket for the build status
[13:34:27.322] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:27.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:161:0) after 1m0s
[13:35:27.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:161:0)
[13:35:27.397] Timer tick, asking Buildbucket for the build status
[13:35:27.595] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:27.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:162:0) after 1m0s
[13:36:27.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:162:0)
[13:36:27.668] Timer tick, asking Buildbucket for the build status
[13:36:27.905] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:27.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:163:0) after 1m0s
[13:37:28.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:163:0)
[13:37:28.064] Timer tick, asking Buildbucket for the build status
[13:37:28.185] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:28.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:164:0) after 1m0s
[13:38:28.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:164:0)
[13:38:28.316] Timer tick, asking Buildbucket for the build status
[13:38:28.386] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:28.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:165:0) after 1m0s
[13:39:28.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:165:0)
[13:39:28.415] Timer tick, asking Buildbucket for the build status
[13:39:28.591] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:28.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:166:0) after 1m0s
[13:40:28.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:166:0)
[13:40:28.710] Timer tick, asking Buildbucket for the build status
[13:40:28.798] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:28.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:167:0) after 1m0s
[13:41:28.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:167:0)
[13:41:28.913] Timer tick, asking Buildbucket for the build status
[13:41:29.127] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:29.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:168:0) after 1m0s
[13:42:29.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:168:0)
[13:42:29.270] Timer tick, asking Buildbucket for the build status
[13:42:29.327] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:29.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:169:0) after 1m0s
[13:43:29.443] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:169:0)
[13:43:29.443] Timer tick, asking Buildbucket for the build status
[13:43:30.422] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:30.422] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:170:0) after 1m0s
[13:44:30.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:170:0)
[13:44:30.465] Timer tick, asking Buildbucket for the build status
[13:44:30.575] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:30.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:171:0) after 1m0s
[13:45:30.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:171:0)
[13:45:30.637] Timer tick, asking Buildbucket for the build status
[13:45:30.764] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:30.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:172:0) after 1m0s
[13:46:30.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:172:0)
[13:46:30.859] Timer tick, asking Buildbucket for the build status
[13:46:31.072] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:31.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:173:0) after 1m0s
[13:47:31.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:173:0)
[13:47:31.059] Timer tick, asking Buildbucket for the build status
[13:47:31.158] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:31.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:174:0) after 1m0s
[13:48:31.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:174:0)
[13:48:31.193] Timer tick, asking Buildbucket for the build status
[13:48:31.322] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:31.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:175:0) after 1m0s
[13:49:31.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:175:0)
[13:49:31.349] Timer tick, asking Buildbucket for the build status
[13:49:31.675] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:31.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:176:0) after 1m0s
[13:50:31.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:176:0)
[13:50:31.701] Timer tick, asking Buildbucket for the build status
[13:50:31.783] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:31.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:177:0) after 1m0s
[13:51:31.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:177:0)
[13:51:31.814] Timer tick, asking Buildbucket for the build status
[13:51:31.997] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:31.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:178:0) after 1m0s
[13:52:32.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:178:0)
[13:52:32.024] Timer tick, asking Buildbucket for the build status
[13:52:32.150] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:32.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:179:0) after 1m0s
[13:53:32.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:179:0)
[13:53:32.192] Timer tick, asking Buildbucket for the build status
[13:53:32.308] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:32.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:180:0) after 1m0s
[13:54:32.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:180:0)
[13:54:32.422] Timer tick, asking Buildbucket for the build status
[13:54:32.650] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:32.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:181:0) after 1m0s
[13:55:32.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:181:0)
[13:55:32.683] Timer tick, asking Buildbucket for the build status
[13:55:32.800] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:32.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:182:0) after 1m0s
[13:56:32.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:182:0)
[13:56:32.907] Timer tick, asking Buildbucket for the build status
[13:56:33.068] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:33.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:183:0) after 1m0s
[13:57:33.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:183:0)
[13:57:33.099] Timer tick, asking Buildbucket for the build status
[13:57:33.352] Build 8872629928364184544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:33.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038059990777887424:184:0) after 1m0s
[13:58:08.443] Received PubSub notification, asking Buildbucket for the build status
[13:58:08.588] Build 8872629928364184544: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:58:08.588] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1596808686749964",
    "created_by": "project:infra",
    "created_ts": "1596797740549670",
    "id": "8872629928364184544",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4226.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f8b247af-3497-4917-b44d-7802d3bdab4d\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4226.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-fklq\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5472-d0af7f3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1596797794485828",
    "status": "COMPLETED",
    "status_changed_ts": "1596808687621532",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038059990777887424",
      "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/8872629928364184544/+/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:4de16174d7373610",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1596808688039663",
    "url": "https://ci.chromium.org/b/8872629928364184544",
    "utcnow_ts": "1596808688575669"
  }
}
[13:58:08.588] Invocation finished in 3h2m29.724048796s with status SUCCEEDED