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.4199.0"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[08:07:06.564] New invocation is queued and will start shortly
[08:07:06.564] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:07:08.911] Starting the invocation (attempt 1)
[08:07:08.954] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:07:08.954] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:07:08.954] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9040516712404263776",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4199.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"6f5252b0-d99d-46cf-bd1f-367676f82104\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4199.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:9040516712404263776",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[08:07:09.799] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1594454829103052",
    "id": "8875086649076346832",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4199.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"6f5252b0-d99d-46cf-bd1f-367676f82104\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4199.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1594454829493149",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9040516712404263776",
      "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/8875086649076346832/+/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": "1594454829493964",
    "url": "https://ci.chromium.org/b/8875086649076346832",
    "utcnow_ts": "1594454829784191"
  }
}
[08:07:09.799] Task URL: https://ci.chromium.org/b/8875086649076346832
[08:07:09.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:2:0) after 1m0s
[08:08:01.853] Received PubSub notification, asking Buildbucket for the build status
[08:08:02.384] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:09.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:2:0)
[08:08:09.852] Timer tick, asking Buildbucket for the build status
[08:08:09.973] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:09.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:4:0) after 1m0s
[08:09:10.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:4:0)
[08:09:10.013] Timer tick, asking Buildbucket for the build status
[08:09:10.434] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:10.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:5:0) after 1m0s
[08:10:10.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:5:0)
[08:10:10.530] Timer tick, asking Buildbucket for the build status
[08:10:10.688] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:10.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:6:0) after 1m0s
[08:11:10.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:6:0)
[08:11:10.797] Timer tick, asking Buildbucket for the build status
[08:11:10.933] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:10.933] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:7:0) after 1m0s
[08:12:10.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:7:0)
[08:12:10.981] Timer tick, asking Buildbucket for the build status
[08:12:11.478] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:11.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:8:0) after 1m0s
[08:13:11.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:8:0)
[08:13:11.815] Timer tick, asking Buildbucket for the build status
[08:13:12.072] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:12.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:9:0) after 1m0s
[08:14:12.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:9:0)
[08:14:12.349] Timer tick, asking Buildbucket for the build status
[08:14:12.463] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:12.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:10:0) after 1m0s
[08:15:12.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:10:0)
[08:15:12.603] Timer tick, asking Buildbucket for the build status
[08:15:13.085] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:13.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:11:0) after 1m0s
[08:16:13.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:11:0)
[08:16:13.119] Timer tick, asking Buildbucket for the build status
[08:16:13.192] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:13.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:12:0) after 1m0s
[08:17:13.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:12:0)
[08:17:13.328] Timer tick, asking Buildbucket for the build status
[08:17:13.442] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:13.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:13:0) after 1m0s
[08:18:13.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:13:0)
[08:18:13.561] Timer tick, asking Buildbucket for the build status
[08:18:13.754] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:13.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:14:0) after 1m0s
[08:19:13.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:14:0)
[08:19:13.794] Timer tick, asking Buildbucket for the build status
[08:19:13.992] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:13.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:15:0) after 1m0s
[08:20:14.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:15:0)
[08:20:14.036] Timer tick, asking Buildbucket for the build status
[08:20:14.213] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:14.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:16:0) after 1m0s
[08:21:14.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:16:0)
[08:21:14.273] Timer tick, asking Buildbucket for the build status
[08:21:14.434] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:14.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:17:0) after 1m0s
[08:22:14.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:17:0)
[08:22:14.528] Timer tick, asking Buildbucket for the build status
[08:22:14.648] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:14.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:18:0) after 1m0s
[08:23:14.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:18:0)
[08:23:14.679] Timer tick, asking Buildbucket for the build status
[08:23:14.814] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:14.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:19:0) after 1m0s
[08:24:14.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:19:0)
[08:24:14.884] Timer tick, asking Buildbucket for the build status
[08:24:15.277] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:15.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:20:0) after 1m0s
[08:25:15.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:20:0)
[08:25:15.299] Timer tick, asking Buildbucket for the build status
[08:25:16.077] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:16.077] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:21:0) after 1m0s
[08:26:16.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:21:0)
[08:26:16.112] Timer tick, asking Buildbucket for the build status
[08:26:16.236] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:16.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:22:0) after 1m0s
[08:27:16.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:22:0)
[08:27:16.281] Timer tick, asking Buildbucket for the build status
[08:27:16.399] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:16.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:23:0) after 1m0s
[08:28:16.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:23:0)
[08:28:16.433] Timer tick, asking Buildbucket for the build status
[08:28:16.609] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:16.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:24:0) after 1m0s
[08:29:16.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:24:0)
[08:29:16.634] Timer tick, asking Buildbucket for the build status
[08:29:17.863] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:17.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:25:0) after 1m0s
[08:30:17.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:25:0)
[08:30:17.949] Timer tick, asking Buildbucket for the build status
[08:30:18.088] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:18.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:26:0) after 1m0s
[08:31:18.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:26:0)
[08:31:18.157] Timer tick, asking Buildbucket for the build status
[08:31:18.511] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:18.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:27:0) after 1m0s
[08:32:18.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:27:0)
[08:32:18.616] Timer tick, asking Buildbucket for the build status
[08:32:18.983] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:18.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:28:0) after 1m0s
[08:33:19.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:28:0)
[08:33:19.053] Timer tick, asking Buildbucket for the build status
[08:33:19.581] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:19.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:29:0) after 1m0s
[08:34:19.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:29:0)
[08:34:19.635] Timer tick, asking Buildbucket for the build status
[08:34:19.805] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:19.805] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:30:0) after 1m0s
[08:35:19.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:30:0)
[08:35:19.898] Timer tick, asking Buildbucket for the build status
[08:35:20.096] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:20.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:31:0) after 1m0s
[08:36:20.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:31:0)
[08:36:20.111] Timer tick, asking Buildbucket for the build status
[08:36:20.249] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:20.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:32:0) after 1m0s
[08:37:20.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:32:0)
[08:37:20.263] Timer tick, asking Buildbucket for the build status
[08:37:20.393] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:20.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:33:0) after 1m0s
[08:38:20.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:33:0)
[08:38:20.457] Timer tick, asking Buildbucket for the build status
[08:38:20.791] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:20.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:34:0) after 1m0s
[08:39:20.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:34:0)
[08:39:20.842] Timer tick, asking Buildbucket for the build status
[08:39:21.216] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:21.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:35:0) after 1m0s
[08:40:21.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:35:0)
[08:40:21.256] Timer tick, asking Buildbucket for the build status
[08:40:21.449] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:21.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:36:0) after 1m0s
[08:41:21.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:36:0)
[08:41:21.520] Timer tick, asking Buildbucket for the build status
[08:41:22.176] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:22.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:37:0) after 1m0s
[08:42:22.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:37:0)
[08:42:22.205] Timer tick, asking Buildbucket for the build status
[08:42:22.434] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:22.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:38:0) after 1m0s
[08:43:22.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:38:0)
[08:43:22.457] Timer tick, asking Buildbucket for the build status
[08:43:22.842] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:22.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:39:0) after 1m0s
[08:44:22.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:39:0)
[08:44:22.866] Timer tick, asking Buildbucket for the build status
[08:44:23.024] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:23.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:40:0) after 1m0s
[08:45:23.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:40:0)
[08:45:23.079] Timer tick, asking Buildbucket for the build status
[08:45:23.286] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:23.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:41:0) after 1m0s
[08:46:23.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:41:0)
[08:46:23.322] Timer tick, asking Buildbucket for the build status
[08:46:25.803] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:25.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:42:0) after 1m0s
[08:47:25.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:42:0)
[08:47:25.903] Timer tick, asking Buildbucket for the build status
[08:47:26.318] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:26.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:43:0) after 1m0s
[08:48:26.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:43:0)
[08:48:26.369] Timer tick, asking Buildbucket for the build status
[08:48:26.552] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:26.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:44:0) after 1m0s
[08:49:26.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:44:0)
[08:49:26.819] Timer tick, asking Buildbucket for the build status
[08:49:27.017] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:27.017] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:45:0) after 1m0s
[08:50:27.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:45:0)
[08:50:27.238] Timer tick, asking Buildbucket for the build status
[08:50:27.378] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:27.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:46:0) after 1m0s
[08:51:27.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:46:0)
[08:51:27.594] Timer tick, asking Buildbucket for the build status
[08:51:28.227] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:28.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:47:0) after 1m0s
[08:52:28.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:47:0)
[08:52:28.424] Timer tick, asking Buildbucket for the build status
[08:52:28.696] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:28.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:48:0) after 1m0s
[08:53:28.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:48:0)
[08:53:28.849] Timer tick, asking Buildbucket for the build status
[08:53:29.014] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:29.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:49:0) after 1m0s
[08:54:29.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:49:0)
[08:54:29.088] Timer tick, asking Buildbucket for the build status
[08:54:29.247] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:29.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:50:0) after 1m0s
[08:55:29.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:50:0)
[08:55:29.271] Timer tick, asking Buildbucket for the build status
[08:55:29.418] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:29.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:51:0) after 1m0s
[08:56:29.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:51:0)
[08:56:29.520] Timer tick, asking Buildbucket for the build status
[08:56:29.707] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:29.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:52:0) after 1m0s
[08:57:29.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:52:0)
[08:57:29.816] Timer tick, asking Buildbucket for the build status
[08:57:30.010] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:30.010] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:53:0) after 1m0s
[08:58:30.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:53:0)
[08:58:30.157] Timer tick, asking Buildbucket for the build status
[08:58:30.266] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:30.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:54:0) after 1m0s
[08:59:30.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:54:0)
[08:59:30.357] Timer tick, asking Buildbucket for the build status
[08:59:30.794] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:30.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:55:0) after 1m0s
[09:00:30.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:55:0)
[09:00:30.828] Timer tick, asking Buildbucket for the build status
[09:00:31.891] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:31.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:56:0) after 1m0s
[09:01:31.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:56:0)
[09:01:31.949] Timer tick, asking Buildbucket for the build status
[09:01:33.562] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:33.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:57:0) after 1m0s
[09:02:33.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:57:0)
[09:02:33.618] Timer tick, asking Buildbucket for the build status
[09:02:33.879] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:33.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:58:0) after 1m0s
[09:03:33.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:58:0)
[09:03:33.906] Timer tick, asking Buildbucket for the build status
[09:03:34.045] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:34.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:59:0) after 1m0s
[09:04:34.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:59:0)
[09:04:34.200] Timer tick, asking Buildbucket for the build status
[09:04:35.207] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:35.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:60:0) after 1m0s
[09:05:35.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:60:0)
[09:05:35.286] Timer tick, asking Buildbucket for the build status
[09:05:35.722] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:35.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:61:0) after 1m0s
[09:06:35.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:61:0)
[09:06:35.881] Timer tick, asking Buildbucket for the build status
[09:06:36.320] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:36.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:62:0) after 1m0s
[09:07:36.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:62:0)
[09:07:36.433] Timer tick, asking Buildbucket for the build status
[09:07:36.924] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:36.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:63:0) after 1m0s
[09:08:36.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:63:0)
[09:08:36.999] Timer tick, asking Buildbucket for the build status
[09:08:37.357] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:37.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:64:0) after 1m0s
[09:09:37.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:64:0)
[09:09:37.388] Timer tick, asking Buildbucket for the build status
[09:09:37.710] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:37.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:65:0) after 1m0s
[09:10:37.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:65:0)
[09:10:37.775] Timer tick, asking Buildbucket for the build status
[09:10:37.853] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:37.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:66:0) after 1m0s
[09:11:37.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:66:0)
[09:11:37.911] Timer tick, asking Buildbucket for the build status
[09:11:38.083] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:38.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:67:0) after 1m0s
[09:12:38.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:67:0)
[09:12:38.107] Timer tick, asking Buildbucket for the build status
[09:12:38.355] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:38.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:68:0) after 1m0s
[09:13:38.443] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:68:0)
[09:13:38.443] Timer tick, asking Buildbucket for the build status
[09:13:38.599] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:38.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:69:0) after 1m0s
[09:14:38.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:69:0)
[09:14:38.650] Timer tick, asking Buildbucket for the build status
[09:14:39.124] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:39.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:70:0) after 1m0s
[09:15:39.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:70:0)
[09:15:39.164] Timer tick, asking Buildbucket for the build status
[09:15:39.659] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:39.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:71:0) after 1m0s
[09:16:39.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:71:0)
[09:16:39.661] Timer tick, asking Buildbucket for the build status
[09:16:39.850] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:39.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:72:0) after 1m0s
[09:17:39.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:72:0)
[09:17:39.923] Timer tick, asking Buildbucket for the build status
[09:17:40.591] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:40.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:73:0) after 1m0s
[09:18:40.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:73:0)
[09:18:40.672] Timer tick, asking Buildbucket for the build status
[09:18:40.872] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:40.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:74:0) after 1m0s
[09:19:40.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:74:0)
[09:19:40.961] Timer tick, asking Buildbucket for the build status
[09:19:41.513] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:41.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:75:0) after 1m0s
[09:20:41.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:75:0)
[09:20:41.545] Timer tick, asking Buildbucket for the build status
[09:20:41.703] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:41.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:76:0) after 1m0s
[09:21:41.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:76:0)
[09:21:41.735] Timer tick, asking Buildbucket for the build status
[09:21:41.946] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:41.946] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:77:0) after 1m0s
[09:22:42.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:77:0)
[09:22:42.020] Timer tick, asking Buildbucket for the build status
[09:22:42.166] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:42.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:78:0) after 1m0s
[09:23:42.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:78:0)
[09:23:42.242] Timer tick, asking Buildbucket for the build status
[09:23:44.897] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:44.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:79:0) after 1m0s
[09:24:45.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:79:0)
[09:24:45.459] Timer tick, asking Buildbucket for the build status
[09:24:46.124] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:46.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:80:0) after 1m0s
[09:25:46.171] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:80:0)
[09:25:46.171] Timer tick, asking Buildbucket for the build status
[09:25:46.405] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:46.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:81:0) after 1m0s
[09:26:46.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:81:0)
[09:26:46.495] Timer tick, asking Buildbucket for the build status
[09:26:46.666] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:46.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:82:0) after 1m0s
[09:27:46.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:82:0)
[09:27:46.764] Timer tick, asking Buildbucket for the build status
[09:27:47.003] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:47.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:83:0) after 1m0s
[09:28:47.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:83:0)
[09:28:47.079] Timer tick, asking Buildbucket for the build status
[09:28:47.272] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:47.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:84:0) after 1m0s
[09:29:47.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:84:0)
[09:29:47.276] Timer tick, asking Buildbucket for the build status
[09:29:47.708] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:47.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:85:0) after 1m0s
[09:30:47.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:85:0)
[09:30:47.818] Timer tick, asking Buildbucket for the build status
[09:30:47.892] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:47.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:86:0) after 1m0s
[09:31:48.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:86:0)
[09:31:48.067] Timer tick, asking Buildbucket for the build status
[09:31:48.247] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:48.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:87:0) after 1m0s
[09:32:48.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:87:0)
[09:32:48.275] Timer tick, asking Buildbucket for the build status
[09:32:48.459] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:48.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:88:0) after 1m0s
[09:33:48.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:88:0)
[09:33:48.508] Timer tick, asking Buildbucket for the build status
[09:33:48.724] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:48.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:89:0) after 1m0s
[09:34:48.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:89:0)
[09:34:48.822] Timer tick, asking Buildbucket for the build status
[09:34:49.006] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:49.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:90:0) after 1m0s
[09:35:49.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:90:0)
[09:35:49.299] Timer tick, asking Buildbucket for the build status
[09:35:49.528] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:49.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:91:0) after 1m0s
[09:36:49.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:91:0)
[09:36:49.673] Timer tick, asking Buildbucket for the build status
[09:36:49.853] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:49.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:92:0) after 1m0s
[09:37:50.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:92:0)
[09:37:50.127] Timer tick, asking Buildbucket for the build status
[09:37:50.401] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:50.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:93:0) after 1m0s
[09:38:50.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:93:0)
[09:38:50.506] Timer tick, asking Buildbucket for the build status
[09:38:50.747] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:50.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:94:0) after 1m0s
[09:39:50.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:94:0)
[09:39:50.777] Timer tick, asking Buildbucket for the build status
[09:39:50.936] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:50.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:95:0) after 1m0s
[09:40:51.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:95:0)
[09:40:51.037] Timer tick, asking Buildbucket for the build status
[09:40:51.149] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:51.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:96:0) after 1m0s
[09:41:51.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:96:0)
[09:41:51.226] Timer tick, asking Buildbucket for the build status
[09:41:51.626] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:51.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:97:0) after 1m0s
[09:42:51.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:97:0)
[09:42:51.653] Timer tick, asking Buildbucket for the build status
[09:42:51.811] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:51.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:98:0) after 1m0s
[09:43:51.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:98:0)
[09:43:51.836] Timer tick, asking Buildbucket for the build status
[09:43:52.185] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:52.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:99:0) after 1m0s
[09:44:52.305] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:99:0)
[09:44:52.305] Timer tick, asking Buildbucket for the build status
[09:44:52.392] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:52.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:100:0) after 1m0s
[09:45:52.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:100:0)
[09:45:52.422] Timer tick, asking Buildbucket for the build status
[09:45:52.924] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:52.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:101:0) after 1m0s
[09:46:52.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:101:0)
[09:46:52.998] Timer tick, asking Buildbucket for the build status
[09:46:53.284] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:53.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:102:0) after 1m0s
[09:47:53.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:102:0)
[09:47:53.355] Timer tick, asking Buildbucket for the build status
[09:47:53.561] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:53.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:103:0) after 1m0s
[09:48:53.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:103:0)
[09:48:53.742] Timer tick, asking Buildbucket for the build status
[09:48:54.247] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:54.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:104:0) after 1m0s
[09:49:54.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:104:0)
[09:49:54.287] Timer tick, asking Buildbucket for the build status
[09:49:54.440] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:54.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:105:0) after 1m0s
[09:50:54.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:105:0)
[09:50:54.479] Timer tick, asking Buildbucket for the build status
[09:50:54.909] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:54.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:106:0) after 1m0s
[09:51:54.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:106:0)
[09:51:54.959] Timer tick, asking Buildbucket for the build status
[09:51:55.101] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:55.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:107:0) after 1m0s
[09:52:55.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:107:0)
[09:52:55.162] Timer tick, asking Buildbucket for the build status
[09:52:55.487] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:55.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:108:0) after 1m0s
[09:53:55.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:108:0)
[09:53:55.557] Timer tick, asking Buildbucket for the build status
[09:53:55.691] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:55.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:109:0) after 1m0s
[09:54:55.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:109:0)
[09:54:55.758] Timer tick, asking Buildbucket for the build status
[09:54:56.232] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:56.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:110:0) after 1m0s
[09:55:56.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:110:0)
[09:55:56.274] Timer tick, asking Buildbucket for the build status
[09:55:56.954] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:56.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:111:0) after 1m0s
[09:56:56.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:111:0)
[09:56:56.989] Timer tick, asking Buildbucket for the build status
[09:56:57.202] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:57.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:112:0) after 1m0s
[09:57:57.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:112:0)
[09:57:57.237] Timer tick, asking Buildbucket for the build status
[09:58:00.267] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:00.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:113:0) after 1m0s
[09:59:00.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:113:0)
[09:59:00.528] Timer tick, asking Buildbucket for the build status
[09:59:00.652] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:00.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:114:0) after 1m0s
[10:00:00.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:114:0)
[10:00:00.760] Timer tick, asking Buildbucket for the build status
[10:00:01.108] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:01.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:115:0) after 1m0s
[10:01:02.952] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:115:0)
[10:01:02.952] Timer tick, asking Buildbucket for the build status
[10:01:03.237] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:03.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:116:0) after 1m0s
[10:02:03.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:116:0)
[10:02:03.274] Timer tick, asking Buildbucket for the build status
[10:02:03.641] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:03.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:117:0) after 1m0s
[10:03:03.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:117:0)
[10:03:03.721] Timer tick, asking Buildbucket for the build status
[10:03:04.752] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:04.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:118:0) after 1m0s
[10:04:04.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:118:0)
[10:04:04.784] Timer tick, asking Buildbucket for the build status
[10:04:04.937] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:04.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:119:0) after 1m0s
[10:05:04.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:119:0)
[10:05:04.968] Timer tick, asking Buildbucket for the build status
[10:05:05.149] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:05.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:120:0) after 1m0s
[10:06:05.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:120:0)
[10:06:05.237] Timer tick, asking Buildbucket for the build status
[10:06:05.510] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:05.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:121:0) after 1m0s
[10:07:05.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:121:0)
[10:07:05.586] Timer tick, asking Buildbucket for the build status
[10:07:05.703] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:05.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:122:0) after 1m0s
[10:08:05.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:122:0)
[10:08:05.727] Timer tick, asking Buildbucket for the build status
[10:08:06.007] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:06.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:123:0) after 1m0s
[10:09:06.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:123:0)
[10:09:06.041] Timer tick, asking Buildbucket for the build status
[10:09:06.375] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:06.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:124:0) after 1m0s
[10:10:06.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:124:0)
[10:10:06.611] Timer tick, asking Buildbucket for the build status
[10:10:07.216] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:07.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:125:0) after 1m0s
[10:11:07.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:125:0)
[10:11:07.488] Timer tick, asking Buildbucket for the build status
[10:11:09.212] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:09.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:126:0) after 1m0s
[10:12:09.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:126:0)
[10:12:09.252] Timer tick, asking Buildbucket for the build status
[10:12:09.377] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:09.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:127:0) after 1m0s
[10:13:09.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:127:0)
[10:13:09.387] Timer tick, asking Buildbucket for the build status
[10:13:09.739] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:09.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:128:0) after 1m0s
[10:14:09.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:128:0)
[10:14:09.752] Timer tick, asking Buildbucket for the build status
[10:14:09.914] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:09.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:129:0) after 1m0s
[10:15:09.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:129:0)
[10:15:09.973] Timer tick, asking Buildbucket for the build status
[10:15:12.460] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:12.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:130:0) after 1m0s
[10:16:12.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:130:0)
[10:16:12.627] Timer tick, asking Buildbucket for the build status
[10:16:12.982] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:12.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:131:0) after 1m0s
[10:17:13.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:131:0)
[10:17:13.109] Timer tick, asking Buildbucket for the build status
[10:17:13.259] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:13.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:132:0) after 1m0s
[10:18:13.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:132:0)
[10:18:13.286] Timer tick, asking Buildbucket for the build status
[10:18:13.467] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:13.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:133:0) after 1m0s
[10:19:13.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:133:0)
[10:19:13.493] Timer tick, asking Buildbucket for the build status
[10:19:13.631] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:13.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:134:0) after 1m0s
[10:20:13.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:134:0)
[10:20:13.666] Timer tick, asking Buildbucket for the build status
[10:20:13.815] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:13.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:135:0) after 1m0s
[10:21:13.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:135:0)
[10:21:13.865] Timer tick, asking Buildbucket for the build status
[10:21:15.103] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:15.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:136:0) after 1m0s
[10:22:15.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:136:0)
[10:22:15.131] Timer tick, asking Buildbucket for the build status
[10:22:18.764] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:18.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:137:0) after 1m0s
[10:23:18.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:137:0)
[10:23:18.876] Timer tick, asking Buildbucket for the build status
[10:23:19.008] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:19.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:138:0) after 1m0s
[10:24:19.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:138:0)
[10:24:19.128] Timer tick, asking Buildbucket for the build status
[10:24:19.310] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:19.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:139:0) after 1m0s
[10:25:19.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:139:0)
[10:25:19.327] Timer tick, asking Buildbucket for the build status
[10:25:19.522] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:19.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:140:0) after 1m0s
[10:26:19.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:140:0)
[10:26:19.591] Timer tick, asking Buildbucket for the build status
[10:26:20.635] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:20.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:141:0) after 1m0s
[10:27:20.663] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:141:0)
[10:27:20.663] Timer tick, asking Buildbucket for the build status
[10:27:21.190] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:21.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:142:0) after 1m0s
[10:28:21.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:142:0)
[10:28:21.234] Timer tick, asking Buildbucket for the build status
[10:28:21.348] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:21.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:143:0) after 1m0s
[10:29:21.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:143:0)
[10:29:21.385] Timer tick, asking Buildbucket for the build status
[10:29:21.514] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:21.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:144:0) after 1m0s
[10:30:21.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:144:0)
[10:30:21.576] Timer tick, asking Buildbucket for the build status
[10:30:21.683] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:21.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:145:0) after 1m0s
[10:31:21.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:145:0)
[10:31:21.780] Timer tick, asking Buildbucket for the build status
[10:31:21.973] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:21.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:146:0) after 1m0s
[10:32:22.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:146:0)
[10:32:22.016] Timer tick, asking Buildbucket for the build status
[10:32:22.172] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:22.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:147:0) after 1m0s
[10:33:22.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:147:0)
[10:33:22.197] Timer tick, asking Buildbucket for the build status
[10:33:22.365] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:22.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:148:0) after 1m0s
[10:34:22.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:148:0)
[10:34:22.397] Timer tick, asking Buildbucket for the build status
[10:34:22.883] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:22.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:149:0) after 1m0s
[10:35:22.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:149:0)
[10:35:22.912] Timer tick, asking Buildbucket for the build status
[10:35:24.296] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:24.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:150:0) after 1m0s
[10:36:24.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:150:0)
[10:36:24.699] Timer tick, asking Buildbucket for the build status
[10:36:24.844] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:24.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:151:0) after 1m0s
[10:37:25.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:151:0)
[10:37:25.053] Timer tick, asking Buildbucket for the build status
[10:37:25.241] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:25.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:152:0) after 1m0s
[10:38:25.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:152:0)
[10:38:25.641] Timer tick, asking Buildbucket for the build status
[10:38:26.249] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:26.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:153:0) after 1m0s
[10:39:26.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:153:0)
[10:39:26.379] Timer tick, asking Buildbucket for the build status
[10:39:26.501] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:26.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:154:0) after 1m0s
[10:40:26.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:154:0)
[10:40:26.621] Timer tick, asking Buildbucket for the build status
[10:40:26.774] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:26.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:155:0) after 1m0s
[10:41:26.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:155:0)
[10:41:26.856] Timer tick, asking Buildbucket for the build status
[10:41:26.982] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:26.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:156:0) after 1m0s
[10:42:27.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:156:0)
[10:42:27.018] Timer tick, asking Buildbucket for the build status
[10:42:27.415] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:27.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:157:0) after 1m0s
[10:43:27.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:157:0)
[10:43:27.434] Timer tick, asking Buildbucket for the build status
[10:43:27.615] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:27.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:158:0) after 1m0s
[10:44:27.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:158:0)
[10:44:27.697] Timer tick, asking Buildbucket for the build status
[10:44:29.017] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:29.017] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:159:0) after 1m0s
[10:45:29.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:159:0)
[10:45:29.128] Timer tick, asking Buildbucket for the build status
[10:45:29.272] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:29.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:160:0) after 1m0s
[10:46:29.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:160:0)
[10:46:29.333] Timer tick, asking Buildbucket for the build status
[10:46:29.497] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:29.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:161:0) after 1m0s
[10:47:29.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:161:0)
[10:47:29.554] Timer tick, asking Buildbucket for the build status
[10:47:29.814] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:29.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:162:0) after 1m0s
[10:48:29.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:162:0)
[10:48:29.861] Timer tick, asking Buildbucket for the build status
[10:48:30.073] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:30.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:163:0) after 1m0s
[10:49:30.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:163:0)
[10:49:30.741] Timer tick, asking Buildbucket for the build status
[10:49:31.021] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:31.021] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:164:0) after 1m0s
[10:50:31.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:164:0)
[10:50:31.263] Timer tick, asking Buildbucket for the build status
[10:50:31.431] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:31.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:165:0) after 1m0s
[10:51:31.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:165:0)
[10:51:31.861] Timer tick, asking Buildbucket for the build status
[10:51:31.998] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:31.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:166:0) after 1m0s
[10:52:32.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:166:0)
[10:52:32.114] Timer tick, asking Buildbucket for the build status
[10:52:32.449] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:32.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:167:0) after 1m0s
[10:53:32.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:167:0)
[10:53:32.665] Timer tick, asking Buildbucket for the build status
[10:53:32.811] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:32.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:168:0) after 1m0s
[10:54:32.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:168:0)
[10:54:32.959] Timer tick, asking Buildbucket for the build status
[10:54:33.115] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:33.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:169:0) after 1m0s
[10:55:33.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:169:0)
[10:55:33.489] Timer tick, asking Buildbucket for the build status
[10:55:33.676] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:33.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:170:0) after 1m0s
[10:56:33.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:170:0)
[10:56:33.822] Timer tick, asking Buildbucket for the build status
[10:56:34.094] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:34.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:171:0) after 1m0s
[10:57:34.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:171:0)
[10:57:34.096] Timer tick, asking Buildbucket for the build status
[10:57:34.620] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:34.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:172:0) after 1m0s
[10:58:34.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:172:0)
[10:58:34.810] Timer tick, asking Buildbucket for the build status
[10:58:34.995] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:34.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:173:0) after 1m0s
[10:59:35.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:173:0)
[10:59:35.036] Timer tick, asking Buildbucket for the build status
[10:59:35.187] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:35.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:174:0) after 1m0s
[11:00:35.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:174:0)
[11:00:35.376] Timer tick, asking Buildbucket for the build status
[11:00:35.611] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:35.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:175:0) after 1m0s
[11:01:35.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:175:0)
[11:01:35.692] Timer tick, asking Buildbucket for the build status
[11:01:35.843] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:35.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:176:0) after 1m0s
[11:02:35.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:176:0)
[11:02:35.960] Timer tick, asking Buildbucket for the build status
[11:02:36.124] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:36.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:177:0) after 1m0s
[11:03:36.360] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:177:0)
[11:03:36.360] Timer tick, asking Buildbucket for the build status
[11:03:36.622] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:36.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:178:0) after 1m0s
[11:04:36.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:178:0)
[11:04:36.684] Timer tick, asking Buildbucket for the build status
[11:04:36.813] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:36.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:179:0) after 1m0s
[11:05:37.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:179:0)
[11:05:37.024] Timer tick, asking Buildbucket for the build status
[11:05:37.911] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:37.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:180:0) after 1m0s
[11:06:37.978] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:180:0)
[11:06:37.978] Timer tick, asking Buildbucket for the build status
[11:06:38.134] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:38.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:181:0) after 1m0s
[11:07:38.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:181:0)
[11:07:38.246] Timer tick, asking Buildbucket for the build status
[11:07:39.207] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:39.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:182:0) after 1m0s
[11:08:39.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:182:0)
[11:08:39.786] Timer tick, asking Buildbucket for the build status
[11:08:39.876] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:39.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:183:0) after 1m0s
[11:09:40.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:183:0)
[11:09:40.152] Timer tick, asking Buildbucket for the build status
[11:09:40.311] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:40.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:184:0) after 1m0s
[11:10:40.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:184:0)
[11:10:40.723] Timer tick, asking Buildbucket for the build status
[11:10:41.036] Build 8875086649076346832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:41.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040516712404263776:185:0) after 1m0s
[11:10:57.183] Received PubSub notification, asking Buildbucket for the build status
[11:10:57.245] Build 8875086649076346832: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:10:57.245] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1594465855837766",
    "created_by": "project:infra",
    "created_ts": "1594454829103052",
    "id": "8875086649076346832",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4199.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"6f5252b0-d99d-46cf-bd1f-367676f82104\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4199.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-szpm\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5378-e275056\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1594454880828462",
    "status": "COMPLETED",
    "status_changed_ts": "1594465856584894",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9040516712404263776",
      "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/8875086649076346832/+/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:4d55bb73c8f00410",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1594465856599809",
    "url": "https://ci.chromium.org/b/8875086649076346832",
    "utcnow_ts": "1594465857238430"
  }
}
[11:10:57.245] Invocation finished in 3h3m50.698671316s with status SUCCEEDED